builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1482748922.78 results: success (0) buildid: 20161226004003 builduid: 56189c185af14b6fa3346d6a7cffe87e revision: 39582d06756a9ff47993d4097b4fb25f041be406 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:02.781328) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:02.781791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:02.782130) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:02.797263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:02.797588) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-26 02:42:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-12-26 02:42:03 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122103 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:02.937584) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:02.938380) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019641 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:02.993622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-26 02:42:02.994332) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 39582d06756a9ff47993d4097b4fb25f041be406 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 39582d06756a9ff47993d4097b4fb25f041be406 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-26 02:42:03,658 truncating revision to first 12 chars 2016-12-26 02:42:03,658 Setting DEBUG logging. 2016-12-26 02:42:03,658 attempt 1/10 2016-12-26 02:42:03,658 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/39582d06756a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-26 02:42:04,903 unpacking tar archive at: mozilla-aurora-39582d06756a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.579748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-26 02:42:04.592034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:04.592370) ========= script_repo_revision: 39582d06756a9ff47993d4097b4fb25f041be406 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:04.592812) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:04.593138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-26 02:42:04.604891) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-26 02:42:04.605415) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:42:05 INFO - MultiFileLogger online at 20161226 02:42:05 in /builds/slave/test 02:42:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:42:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:42:05 INFO - {'append_to_log': False, 02:42:05 INFO - 'base_work_dir': '/builds/slave/test', 02:42:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:42:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:42:05 INFO - 'branch': 'Mozilla-Aurora', 02:42:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:42:05 INFO - 'config_files': ('talos/linux_config.py',), 02:42:05 INFO - 'default_actions': ('clobber', 02:42:05 INFO - 'read-buildbot-config', 02:42:05 INFO - 'download-and-extract', 02:42:05 INFO - 'populate-webroot', 02:42:05 INFO - 'create-virtualenv', 02:42:05 INFO - 'install', 02:42:05 INFO - 'run-tests'), 02:42:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:42:05 INFO - 'download_minidump_stackwalk': True, 02:42:05 INFO - 'download_symbols': 'ondemand', 02:42:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:42:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:42:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:42:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:42:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:42:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:42:05 INFO - 'installer_path': 'installer.exe', 02:42:05 INFO - 'log_level': 'info', 02:42:05 INFO - 'log_name': 'talos', 02:42:05 INFO - 'log_to_console': True, 02:42:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:42:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:42:05 INFO - 'opt_config_files': (), 02:42:05 INFO - 'pip_index': False, 02:42:05 INFO - 'sps_profile': False, 02:42:05 INFO - 'sps_profile_interval': 0, 02:42:05 INFO - 'suite': 'dromaeojs', 02:42:05 INFO - 'system_bits': '32', 02:42:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:42:05 INFO - 'title': 'talos-linux64-ix-012', 02:42:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:42:05 INFO - 'use_talos_json': True, 02:42:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:42:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:42:05 INFO - 'work_dir': 'build'} 02:42:05 INFO - [mozharness: 2016-12-26 10:42:05.373874Z] Running clobber step. 02:42:05 INFO - Running pre-action listener: _resource_record_pre_action 02:42:05 INFO - Running main action method: clobber 02:42:05 INFO - rmtree: /builds/slave/test/build 02:42:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:42:05 INFO - Running post-action listener: _resource_record_post_action 02:42:05 INFO - [mozharness: 2016-12-26 10:42:05.835568Z] Finished clobber step (success) 02:42:05 INFO - [mozharness: 2016-12-26 10:42:05.835668Z] Running read-buildbot-config step. 02:42:05 INFO - Running pre-action listener: _resource_record_pre_action 02:42:05 INFO - Running main action method: read_buildbot_config 02:42:05 INFO - Using buildbot properties: 02:42:05 INFO - { 02:42:05 INFO - "project": "", 02:42:05 INFO - "product": "firefox", 02:42:05 INFO - "script_repo_revision": "production", 02:42:05 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:42:05 INFO - "repository": "", 02:42:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:42:05 INFO - "buildid": "20161226004003", 02:42:05 INFO - "stage_platform": "linux64-pgo", 02:42:05 INFO - "basedir": "/builds/slave/test", 02:42:05 INFO - "nightly_build": "True", 02:42:05 INFO - "buildnumber": 695, 02:42:05 INFO - "slavename": "talos-linux64-ix-012", 02:42:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:42:05 INFO - "platform": "ubuntu64_hw", 02:42:05 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:42:05 INFO - "branch": "mozilla-aurora", 02:42:05 INFO - "repo_path": "releases/mozilla-aurora", 02:42:05 INFO - "revision": "39582d06756a9ff47993d4097b4fb25f041be406", 02:42:05 INFO - "pgo_build": "True", 02:42:05 INFO - "builduid": "56189c185af14b6fa3346d6a7cffe87e", 02:42:05 INFO - "slavebuilddir": "test" 02:42:05 INFO - } 02:42:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:42:05 INFO - Running post-action listener: _resource_record_post_action 02:42:05 INFO - [mozharness: 2016-12-26 10:42:05.838183Z] Finished read-buildbot-config step (success) 02:42:05 INFO - [mozharness: 2016-12-26 10:42:05.838271Z] Running download-and-extract step. 02:42:05 INFO - Running pre-action listener: _resource_record_pre_action 02:42:05 INFO - Running main action method: download_and_extract 02:42:05 INFO - mkdir: /builds/slave/test/build/tests 02:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:05 INFO - trying https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:42:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:42:06 INFO - Downloaded 1361 bytes. 02:42:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:42:06 INFO - Using the following test package requirements: 02:42:06 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:42:06 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:42:06 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:42:06 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:06 INFO - u'jsshell-linux-x86_64.zip'], 02:42:06 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:42:06 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:42:06 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:42:06 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:42:06 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:42:06 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:42:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:42:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:42:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:42:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:42:06 INFO - Http code: 200 02:42:06 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 02:42:06 INFO - x-amz-cf-id: sfnfLn97USGFPUeTnFNAuYHgAfzMT1ClqOERFJ2uQXVOx0S34zFCqQ== 02:42:06 INFO - x-amz-version-id: YLR1vlRtmkycO7heM3Z4PY_0hB_.Vpza 02:42:07 INFO - Expected file size: 21943679 02:42:07 INFO - Obtained file size: 21943679 02:42:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:42:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:42:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:42:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:42:11 INFO - Http code: 200 02:42:11 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 02:42:11 INFO - x-amz-cf-id: 2m8vWJVGaPsp9GYIjoZimgG_Jz5JD2zCmCrHBDRcnYciLQwCpOcNWQ== 02:42:11 INFO - x-amz-version-id: YLR1vlRtmkycO7heM3Z4PY_0hB_.Vpza 02:42:12 INFO - Expected file size: 21943679 02:42:12 INFO - Obtained file size: 21943679 02:42:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:42:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:42:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:42:17 INFO - Http code: 200 02:42:17 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 02:42:17 INFO - x-amz-cf-id: lLGyj49weSMMB-kCaBVKNKqZtRRpADu3CvdaMJDHbCi0HiYKxyTyWA== 02:42:17 INFO - x-amz-version-id: EuFmJFB9ihOI.2AnfYthlmeTmb2ZvnZE 02:42:17 INFO - Expected file size: 14409038 02:42:17 INFO - Obtained file size: 14409038 02:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:17 INFO - trying https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:42:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:42:19 INFO - Downloaded 63980305 bytes. 02:42:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:42:19 INFO - mkdir: /builds/slave/test/properties 02:42:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:42:19 INFO - Writing to file /builds/slave/test/properties/build_url 02:42:19 INFO - Contents: 02:42:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:42:20 INFO - Running post-action listener: _resource_record_post_action 02:42:20 INFO - Running post-action listener: set_extra_try_arguments 02:42:20 INFO - [mozharness: 2016-12-26 10:42:20.497061Z] Finished download-and-extract step (success) 02:42:20 INFO - [mozharness: 2016-12-26 10:42:20.497288Z] Running populate-webroot step. 02:42:20 INFO - Running pre-action listener: _resource_record_pre_action 02:42:20 INFO - Running main action method: populate_webroot 02:42:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:42:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:42:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:42:20 INFO - '--tppagecycles', 02:42:20 INFO - '7'], 02:42:20 INFO - 'tests': ['tsvgm']}}, 02:42:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:42:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:42:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:42:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:42:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:20 INFO - 'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:42:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:42:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:20 INFO - 'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['damp', 'tps']}, 02:42:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:20 INFO - 'tests': ['damp', 'tps']}, 02:42:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['dromaeo_dom']}, 02:42:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:42:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['basic_compositor_video']}, 02:42:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:42:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['a11yr', 02:42:20 INFO - 'ts_paint', 02:42:20 INFO - 'tpaint', 02:42:20 INFO - 'sessionrestore', 02:42:20 INFO - 'sessionrestore_no_auto_restore', 02:42:20 INFO - 'tabpaint']}, 02:42:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:42:20 INFO - 'ts_paint', 02:42:20 INFO - 'tpaint', 02:42:20 INFO - 'sessionrestore', 02:42:20 INFO - 'sessionrestore_no_auto_restore', 02:42:20 INFO - 'tabpaint']}, 02:42:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:42:20 INFO - 'ts_paint', 02:42:20 INFO - 'tpaint', 02:42:20 INFO - 'sessionrestore', 02:42:20 INFO - 'sessionrestore_no_auto_restore', 02:42:20 INFO - 'tabpaint']}, 02:42:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:42:20 INFO - 'ts_paint', 02:42:20 INFO - 'tpaint', 02:42:20 INFO - 'sessionrestore', 02:42:20 INFO - 'sessionrestore_no_auto_restore', 02:42:20 INFO - 'tabpaint']}, 02:42:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['a11yr', 02:42:20 INFO - 'ts_paint', 02:42:20 INFO - 'tpaint', 02:42:20 INFO - 'sessionrestore', 02:42:20 INFO - 'sessionrestore_no_auto_restore', 02:42:20 INFO - 'tabpaint']}, 02:42:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['a11yr', 02:42:20 INFO - 'ts_paint', 02:42:20 INFO - 'tpaint', 02:42:20 INFO - 'sessionrestore', 02:42:20 INFO - 'sessionrestore_no_auto_restore', 02:42:20 INFO - 'tabpaint']}, 02:42:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['tsvgx', 02:42:20 INFO - 'tsvgr_opacity', 02:42:20 INFO - 'tart', 02:42:20 INFO - 'tscrollx', 02:42:20 INFO - 'cart']}, 02:42:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:42:20 INFO - 'tsvgr_opacity', 02:42:20 INFO - 'tart', 02:42:20 INFO - 'tscrollx', 02:42:20 INFO - 'cart']}, 02:42:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:20 INFO - 'talos_options': ['--disable-e10s'], 02:42:20 INFO - 'tests': ['tp5o']}, 02:42:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:20 INFO - 'tests': ['tp5o']}, 02:42:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:20 INFO - 'talos_options': ['--disable-e10s', 02:42:20 INFO - '--xperf_path', 02:42:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:42:20 INFO - 'tests': ['tp5n']}, 02:42:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:20 INFO - 'talos_options': ['--xperf_path', 02:42:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:42:20 INFO - 'tests': ['tp5n']}}, 02:42:20 INFO - 'talos.zip': {'path': '', 02:42:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:42:20 INFO - Running post-action listener: _resource_record_post_action 02:42:20 INFO - [mozharness: 2016-12-26 10:42:20.515825Z] Finished populate-webroot step (success) 02:42:20 INFO - [mozharness: 2016-12-26 10:42:20.515913Z] Running create-virtualenv step. 02:42:20 INFO - Running pre-action listener: _resource_record_pre_action 02:42:20 INFO - Running main action method: create_virtualenv 02:42:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:42:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:42:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:42:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:42:20 INFO - Using real prefix '/usr' 02:42:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:42:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:42:23 INFO - Installing pip.................done. 02:42:23 INFO - Return code: 0 02:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:42:23 INFO - Reading from file tmpfile_stdout 02:42:23 INFO - Output received: 02:42:23 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:42:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d57f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:42:23 INFO - Using env: {'DISPLAY': ':0', 02:42:23 INFO - 'HOME': '/home/cltbld', 02:42:23 INFO - 'LANG': 'en_US.UTF-8', 02:42:23 INFO - 'LANGUAGE': 'en_US:en', 02:42:23 INFO - 'LOGNAME': 'cltbld', 02:42:23 INFO - 'MAIL': '/var/mail/cltbld', 02:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:23 INFO - 'MOZ_NO_REMOTE': '1', 02:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:23 INFO - 'NO_EM_RESTART': '1', 02:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:23 INFO - 'PWD': '/builds/slave/test', 02:42:23 INFO - 'SHELL': '/bin/bash', 02:42:23 INFO - 'SHLVL': '1', 02:42:23 INFO - 'TERM': 'linux', 02:42:23 INFO - 'TMOUT': '86400', 02:42:23 INFO - 'USER': 'cltbld', 02:42:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:23 INFO - '_': '/tools/buildbot/bin/python'} 02:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:42:23 INFO - Cleaning up... 02:42:23 INFO - Return code: 0 02:42:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d57f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:42:23 INFO - Using env: {'DISPLAY': ':0', 02:42:23 INFO - 'HOME': '/home/cltbld', 02:42:23 INFO - 'LANG': 'en_US.UTF-8', 02:42:23 INFO - 'LANGUAGE': 'en_US:en', 02:42:23 INFO - 'LOGNAME': 'cltbld', 02:42:23 INFO - 'MAIL': '/var/mail/cltbld', 02:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:23 INFO - 'MOZ_NO_REMOTE': '1', 02:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:23 INFO - 'NO_EM_RESTART': '1', 02:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:23 INFO - 'PWD': '/builds/slave/test', 02:42:23 INFO - 'SHELL': '/bin/bash', 02:42:23 INFO - 'SHLVL': '1', 02:42:23 INFO - 'TERM': 'linux', 02:42:23 INFO - 'TMOUT': '86400', 02:42:23 INFO - 'USER': 'cltbld', 02:42:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:23 INFO - '_': '/tools/buildbot/bin/python'} 02:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:23 INFO - Downloading/unpacking psutil>=3.1.1 02:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:42:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:42:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:42:25 INFO - Installing collected packages: psutil 02:42:25 INFO - Running setup.py install for psutil 02:42:25 INFO - building 'psutil._psutil_linux' extension 02:42:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:42:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:42:26 INFO - building 'psutil._psutil_posix' extension 02:42:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:42:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:42:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:42:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:42:26 INFO - Successfully installed psutil 02:42:26 INFO - Cleaning up... 02:42:26 INFO - Return code: 0 02:42:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d57f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:42:26 INFO - Using env: {'DISPLAY': ':0', 02:42:26 INFO - 'HOME': '/home/cltbld', 02:42:26 INFO - 'LANG': 'en_US.UTF-8', 02:42:26 INFO - 'LANGUAGE': 'en_US:en', 02:42:26 INFO - 'LOGNAME': 'cltbld', 02:42:26 INFO - 'MAIL': '/var/mail/cltbld', 02:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:26 INFO - 'MOZ_NO_REMOTE': '1', 02:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:26 INFO - 'NO_EM_RESTART': '1', 02:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:26 INFO - 'PWD': '/builds/slave/test', 02:42:26 INFO - 'SHELL': '/bin/bash', 02:42:26 INFO - 'SHLVL': '1', 02:42:26 INFO - 'TERM': 'linux', 02:42:26 INFO - 'TMOUT': '86400', 02:42:26 INFO - 'USER': 'cltbld', 02:42:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:26 INFO - '_': '/tools/buildbot/bin/python'} 02:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:42:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:42:28 INFO - Installing collected packages: mozsystemmonitor 02:42:28 INFO - Running setup.py install for mozsystemmonitor 02:42:28 INFO - Successfully installed mozsystemmonitor 02:42:28 INFO - Cleaning up... 02:42:28 INFO - Return code: 0 02:42:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d57f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:42:28 INFO - Using env: {'DISPLAY': ':0', 02:42:28 INFO - 'HOME': '/home/cltbld', 02:42:28 INFO - 'LANG': 'en_US.UTF-8', 02:42:28 INFO - 'LANGUAGE': 'en_US:en', 02:42:28 INFO - 'LOGNAME': 'cltbld', 02:42:28 INFO - 'MAIL': '/var/mail/cltbld', 02:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:28 INFO - 'MOZ_NO_REMOTE': '1', 02:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:28 INFO - 'NO_EM_RESTART': '1', 02:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:28 INFO - 'PWD': '/builds/slave/test', 02:42:28 INFO - 'SHELL': '/bin/bash', 02:42:28 INFO - 'SHLVL': '1', 02:42:28 INFO - 'TERM': 'linux', 02:42:28 INFO - 'TMOUT': '86400', 02:42:28 INFO - 'USER': 'cltbld', 02:42:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:28 INFO - '_': '/tools/buildbot/bin/python'} 02:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:29 INFO - Downloading/unpacking jsonschema==2.5.1 02:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:42:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:31 INFO - Downloading functools32-3.2.3-2.tar.gz 02:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:42:31 INFO - warning: no files found matching '*.txt' 02:42:31 INFO - no previously-included directories found matching 'build' 02:42:31 INFO - no previously-included directories found matching 'dist' 02:42:31 INFO - no previously-included directories found matching '.git*' 02:42:31 INFO - Installing collected packages: jsonschema, functools32 02:42:31 INFO - Running setup.py install for functools32 02:42:31 INFO - warning: no files found matching '*.txt' 02:42:31 INFO - no previously-included directories found matching 'build' 02:42:31 INFO - no previously-included directories found matching 'dist' 02:42:31 INFO - no previously-included directories found matching '.git*' 02:42:31 INFO - Successfully installed jsonschema functools32 02:42:31 INFO - Cleaning up... 02:42:31 INFO - Return code: 0 02:42:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d57f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:42:31 INFO - Using env: {'DISPLAY': ':0', 02:42:31 INFO - 'HOME': '/home/cltbld', 02:42:31 INFO - 'LANG': 'en_US.UTF-8', 02:42:31 INFO - 'LANGUAGE': 'en_US:en', 02:42:31 INFO - 'LOGNAME': 'cltbld', 02:42:31 INFO - 'MAIL': '/var/mail/cltbld', 02:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:31 INFO - 'MOZ_NO_REMOTE': '1', 02:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:31 INFO - 'NO_EM_RESTART': '1', 02:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:31 INFO - 'PWD': '/builds/slave/test', 02:42:31 INFO - 'SHELL': '/bin/bash', 02:42:31 INFO - 'SHLVL': '1', 02:42:31 INFO - 'TERM': 'linux', 02:42:31 INFO - 'TMOUT': '86400', 02:42:31 INFO - 'USER': 'cltbld', 02:42:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:31 INFO - '_': '/tools/buildbot/bin/python'} 02:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:42:31 INFO - Cleaning up... 02:42:31 INFO - Return code: 0 02:42:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d57f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:42:31 INFO - Using env: {'DISPLAY': ':0', 02:42:31 INFO - 'HOME': '/home/cltbld', 02:42:31 INFO - 'LANG': 'en_US.UTF-8', 02:42:31 INFO - 'LANGUAGE': 'en_US:en', 02:42:31 INFO - 'LOGNAME': 'cltbld', 02:42:31 INFO - 'MAIL': '/var/mail/cltbld', 02:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:31 INFO - 'MOZ_NO_REMOTE': '1', 02:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:31 INFO - 'NO_EM_RESTART': '1', 02:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:31 INFO - 'PWD': '/builds/slave/test', 02:42:31 INFO - 'SHELL': '/bin/bash', 02:42:31 INFO - 'SHLVL': '1', 02:42:31 INFO - 'TERM': 'linux', 02:42:31 INFO - 'TMOUT': '86400', 02:42:31 INFO - 'USER': 'cltbld', 02:42:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:31 INFO - '_': '/tools/buildbot/bin/python'} 02:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:32 INFO - Downloading/unpacking blobuploader==1.2.4 02:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:34 INFO - Downloading blobuploader-1.2.4.tar.gz 02:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:42:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:42:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:34 INFO - Downloading docopt-0.6.1.tar.gz 02:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:42:34 INFO - Installing collected packages: blobuploader, requests, docopt 02:42:34 INFO - Running setup.py install for blobuploader 02:42:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:42:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:42:34 INFO - Running setup.py install for requests 02:42:35 INFO - Running setup.py install for docopt 02:42:35 INFO - Successfully installed blobuploader requests docopt 02:42:35 INFO - Cleaning up... 02:42:35 INFO - Return code: 0 02:42:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d57f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:42:35 INFO - Using env: {'DISPLAY': ':0', 02:42:35 INFO - 'HOME': '/home/cltbld', 02:42:35 INFO - 'LANG': 'en_US.UTF-8', 02:42:35 INFO - 'LANGUAGE': 'en_US:en', 02:42:35 INFO - 'LOGNAME': 'cltbld', 02:42:35 INFO - 'MAIL': '/var/mail/cltbld', 02:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:35 INFO - 'MOZ_NO_REMOTE': '1', 02:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:35 INFO - 'NO_EM_RESTART': '1', 02:42:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:35 INFO - 'PWD': '/builds/slave/test', 02:42:35 INFO - 'SHELL': '/bin/bash', 02:42:35 INFO - 'SHLVL': '1', 02:42:35 INFO - 'TERM': 'linux', 02:42:35 INFO - 'TMOUT': '86400', 02:42:35 INFO - 'USER': 'cltbld', 02:42:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:35 INFO - '_': '/tools/buildbot/bin/python'} 02:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:35 INFO - Running setup.py (path:/tmp/pip-hwuJTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:35 INFO - Running setup.py (path:/tmp/pip-nrbXnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:35 INFO - Running setup.py (path:/tmp/pip-jQURDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:35 INFO - Running setup.py (path:/tmp/pip-5m3i4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:35 INFO - Running setup.py (path:/tmp/pip-olUB2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:36 INFO - Running setup.py (path:/tmp/pip-r8sQus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:36 INFO - Running setup.py (path:/tmp/pip-WUSV0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:36 INFO - Running setup.py (path:/tmp/pip-HO3iNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:36 INFO - Running setup.py (path:/tmp/pip-pffWOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:36 INFO - Running setup.py (path:/tmp/pip-zYGUmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:36 INFO - Running setup.py (path:/tmp/pip-FAzyUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:36 INFO - Running setup.py (path:/tmp/pip-mnWgJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:36 INFO - Running setup.py (path:/tmp/pip-NQ6VFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:36 INFO - Running setup.py (path:/tmp/pip-FSKfIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:36 INFO - Running setup.py (path:/tmp/pip-A2cHqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:36 INFO - Running setup.py (path:/tmp/pip-0sSnh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:36 INFO - Running setup.py (path:/tmp/pip-u3BUJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:42:36 INFO - Running setup.py install for manifestparser 02:42:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:42:36 INFO - Running setup.py install for mozcrash 02:42:37 INFO - Running setup.py install for mozdebug 02:42:37 INFO - Running setup.py install for mozdevice 02:42:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for mozfile 02:42:37 INFO - Running setup.py install for mozhttpd 02:42:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for mozinfo 02:42:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for mozInstall 02:42:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for mozleak 02:42:37 INFO - Running setup.py install for mozlog 02:42:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for moznetwork 02:42:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:42:38 INFO - Running setup.py install for mozprocess 02:42:38 INFO - Running setup.py install for mozprofile 02:42:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:42:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:42:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:42:38 INFO - Running setup.py install for mozrunner 02:42:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:42:38 INFO - Running setup.py install for mozscreenshot 02:42:38 INFO - Running setup.py install for moztest 02:42:38 INFO - Running setup.py install for mozversion 02:42:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:42:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:42:38 INFO - Cleaning up... 02:42:38 INFO - Return code: 0 02:42:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d57f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:42:38 INFO - Using env: {'DISPLAY': ':0', 02:42:38 INFO - 'HOME': '/home/cltbld', 02:42:38 INFO - 'LANG': 'en_US.UTF-8', 02:42:38 INFO - 'LANGUAGE': 'en_US:en', 02:42:38 INFO - 'LOGNAME': 'cltbld', 02:42:38 INFO - 'MAIL': '/var/mail/cltbld', 02:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:38 INFO - 'MOZ_NO_REMOTE': '1', 02:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:38 INFO - 'NO_EM_RESTART': '1', 02:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:38 INFO - 'PWD': '/builds/slave/test', 02:42:38 INFO - 'SHELL': '/bin/bash', 02:42:38 INFO - 'SHLVL': '1', 02:42:38 INFO - 'TERM': 'linux', 02:42:38 INFO - 'TMOUT': '86400', 02:42:38 INFO - 'USER': 'cltbld', 02:42:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:38 INFO - '_': '/tools/buildbot/bin/python'} 02:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:38 INFO - Running setup.py (path:/tmp/pip-kPmkM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:38 INFO - Running setup.py (path:/tmp/pip-TUMe7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:39 INFO - Running setup.py (path:/tmp/pip-cZKH2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:39 INFO - Running setup.py (path:/tmp/pip-bS4OD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:39 INFO - Running setup.py (path:/tmp/pip-OnlT49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:39 INFO - Running setup.py (path:/tmp/pip-f3b0xL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:39 INFO - Running setup.py (path:/tmp/pip-1uvyfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:39 INFO - Running setup.py (path:/tmp/pip-ypx4dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:39 INFO - Running setup.py (path:/tmp/pip-XyUOQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:39 INFO - Running setup.py (path:/tmp/pip-zf5IY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:39 INFO - Running setup.py (path:/tmp/pip-POrtPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:39 INFO - Running setup.py (path:/tmp/pip-AXfhh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:39 INFO - Running setup.py (path:/tmp/pip-86ZKsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:39 INFO - Running setup.py (path:/tmp/pip-AMrAtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:39 INFO - Running setup.py (path:/tmp/pip-a18_kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:40 INFO - Running setup.py (path:/tmp/pip-wOgW2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:40 INFO - Running setup.py (path:/tmp/pip-1MvvSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:42:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:42 INFO - Downloading blessings-1.6.tar.gz 02:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:42:42 INFO - Installing collected packages: blessings 02:42:42 INFO - Running setup.py install for blessings 02:42:42 INFO - Successfully installed blessings 02:42:42 INFO - Cleaning up... 02:42:42 INFO - Return code: 0 02:42:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:42 INFO - Reading from file tmpfile_stdout 02:42:42 INFO - Current package versions: 02:42:42 INFO - argparse == 1.2.1 02:42:42 INFO - blessings == 1.6 02:42:42 INFO - blobuploader == 1.2.4 02:42:42 INFO - docopt == 0.6.1 02:42:42 INFO - functools32 == 3.2.3-2 02:42:42 INFO - jsonschema == 2.5.1 02:42:42 INFO - manifestparser == 1.1 02:42:42 INFO - mozInstall == 1.12 02:42:42 INFO - mozcrash == 1.0 02:42:42 INFO - mozdebug == 0.1 02:42:42 INFO - mozdevice == 0.48 02:42:42 INFO - mozfile == 1.2 02:42:42 INFO - mozhttpd == 0.7 02:42:42 INFO - mozinfo == 0.9 02:42:42 INFO - mozleak == 0.1 02:42:42 INFO - mozlog == 3.4 02:42:42 INFO - moznetwork == 0.27 02:42:42 INFO - mozprocess == 0.23 02:42:42 INFO - mozprofile == 0.28 02:42:42 INFO - mozrunner == 6.13 02:42:42 INFO - mozscreenshot == 0.1 02:42:42 INFO - mozsystemmonitor == 0.3 02:42:42 INFO - moztest == 0.7 02:42:42 INFO - mozversion == 1.4 02:42:42 INFO - psutil == 3.1.1 02:42:42 INFO - requests == 1.2.3 02:42:42 INFO - wsgiref == 0.1.2 02:42:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d57f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:42:42 INFO - Using env: {'DISPLAY': ':0', 02:42:42 INFO - 'HOME': '/home/cltbld', 02:42:42 INFO - 'LANG': 'en_US.UTF-8', 02:42:42 INFO - 'LANGUAGE': 'en_US:en', 02:42:42 INFO - 'LOGNAME': 'cltbld', 02:42:42 INFO - 'MAIL': '/var/mail/cltbld', 02:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:42 INFO - 'MOZ_NO_REMOTE': '1', 02:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:42 INFO - 'NO_EM_RESTART': '1', 02:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:42 INFO - 'PWD': '/builds/slave/test', 02:42:42 INFO - 'SHELL': '/bin/bash', 02:42:42 INFO - 'SHLVL': '1', 02:42:42 INFO - 'TERM': 'linux', 02:42:42 INFO - 'TMOUT': '86400', 02:42:42 INFO - 'USER': 'cltbld', 02:42:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:42 INFO - '_': '/tools/buildbot/bin/python'} 02:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:42:42 INFO - Cleaning up... 02:42:42 INFO - Return code: 0 02:42:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d57f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:42:42 INFO - Using env: {'DISPLAY': ':0', 02:42:42 INFO - 'HOME': '/home/cltbld', 02:42:42 INFO - 'LANG': 'en_US.UTF-8', 02:42:42 INFO - 'LANGUAGE': 'en_US:en', 02:42:42 INFO - 'LOGNAME': 'cltbld', 02:42:42 INFO - 'MAIL': '/var/mail/cltbld', 02:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:42 INFO - 'MOZ_NO_REMOTE': '1', 02:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:42 INFO - 'NO_EM_RESTART': '1', 02:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:42 INFO - 'PWD': '/builds/slave/test', 02:42:42 INFO - 'SHELL': '/bin/bash', 02:42:42 INFO - 'SHLVL': '1', 02:42:42 INFO - 'TERM': 'linux', 02:42:42 INFO - 'TMOUT': '86400', 02:42:42 INFO - 'USER': 'cltbld', 02:42:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:42 INFO - '_': '/tools/buildbot/bin/python'} 02:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:42:43 INFO - Cleaning up... 02:42:43 INFO - Return code: 0 02:42:43 INFO - Running post-action listener: _resource_record_post_action 02:42:43 INFO - Running post-action listener: _start_resource_monitoring 02:42:43 INFO - Starting resource monitoring. 02:42:43 INFO - [mozharness: 2016-12-26 10:42:43.141963Z] Finished create-virtualenv step (success) 02:42:43 INFO - [mozharness: 2016-12-26 10:42:43.142419Z] Running install step. 02:42:43 INFO - Running pre-action listener: _resource_record_pre_action 02:42:43 INFO - Running main action method: install 02:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:43 INFO - Reading from file tmpfile_stdout 02:42:43 INFO - Detecting whether we're running mozinstall >=1.0... 02:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:42:43 INFO - Reading from file tmpfile_stdout 02:42:43 INFO - Output received: 02:42:43 INFO - Usage: mozinstall [options] installer 02:42:43 INFO - Options: 02:42:43 INFO - -h, --help show this help message and exit 02:42:43 INFO - -d DEST, --destination=DEST 02:42:43 INFO - Directory to install application into. [default: 02:42:43 INFO - "/builds/slave/test"] 02:42:43 INFO - --app=APP Application being installed. [default: firefox] 02:42:43 INFO - mkdir: /builds/slave/test/build/application 02:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:42:59 INFO - Reading from file tmpfile_stdout 02:42:59 INFO - Output received: 02:42:59 INFO - /builds/slave/test/build/application/firefox/firefox 02:42:59 INFO - Running post-action listener: _resource_record_post_action 02:42:59 INFO - [mozharness: 2016-12-26 10:42:59.355091Z] Finished install step (success) 02:42:59 INFO - [mozharness: 2016-12-26 10:42:59.355333Z] Running run-tests step. 02:42:59 INFO - Running pre-action listener: _resource_record_pre_action 02:42:59 INFO - Running main action method: run_tests 02:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:42:59 INFO - Python 2.7.3 02:42:59 INFO - Return code: 0 02:42:59 INFO - grabbing minidump binary from tooltool 02:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283cf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:42:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:42:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:42:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:42:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:42:59 INFO - Return code: 0 02:42:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:42:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:42:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:42:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:42:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:42:59 INFO - Using env: {'DISPLAY': ':0', 02:42:59 INFO - 'HOME': '/home/cltbld', 02:42:59 INFO - 'LANG': 'en_US.UTF-8', 02:42:59 INFO - 'LANGUAGE': 'en_US:en', 02:42:59 INFO - 'LOGNAME': 'cltbld', 02:42:59 INFO - 'MAIL': '/var/mail/cltbld', 02:42:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:42:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:59 INFO - 'MOZ_NO_REMOTE': '1', 02:42:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:59 INFO - 'NO_EM_RESTART': '1', 02:42:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:59 INFO - 'PWD': '/builds/slave/test', 02:42:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:42:59 INFO - 'SHELL': '/bin/bash', 02:42:59 INFO - 'SHLVL': '1', 02:42:59 INFO - 'TERM': 'linux', 02:42:59 INFO - 'TMOUT': '86400', 02:42:59 INFO - 'USER': 'cltbld', 02:42:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729', 02:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:59 INFO - '_': '/tools/buildbot/bin/python'} 02:42:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:42:59 INFO - mozversion application_buildid: 20161226004003 02:42:59 INFO - mozversion application_changeset: 39582d06756a9ff47993d4097b4fb25f041be406 02:42:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:42:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:42:59 INFO - mozversion application_name: Firefox 02:42:59 INFO - mozversion application_remotingname: firefox-dev 02:42:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:59 INFO - mozversion application_vendor: Mozilla 02:42:59 INFO - mozversion application_version: 52.0a2 02:42:59 INFO - mozversion platform_buildid: 20161226004003 02:42:59 INFO - mozversion platform_changeset: 39582d06756a9ff47993d4097b4fb25f041be406 02:42:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:59 INFO - mozversion platform_version: 52.0a2 02:42:59 INFO - using testdate: 1482748979 02:42:59 INFO - actual date: 1482748979 02:42:59 INFO - starting webserver on 'localhost:45610' 02:42:59 INFO - SUITE-START | Running 2 tests 02:42:59 INFO - TEST-START | dromaeo_css 02:42:59 INFO - operating with platform_type : linux_ 02:42:59 INFO - Initialising browser for dromaeo_css test... 02:42:59 INFO - TEST-INFO | started process 12931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ8uvix/profile http://localhost:45610/getInfo.html) 02:43:03 INFO - PROCESS | 12931 | __metrics Screen width/height:1600/1200 02:43:03 INFO - PROCESS | 12931 | colorDepth:24 02:43:03 INFO - PROCESS | 12931 | Browser inner width/height: 1024/697 02:43:03 INFO - PROCESS | 12931 | __metrics 02:43:03 INFO - PROCESS | 12931 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:43:03 INFO - PROCESS | 12931 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:43:04 INFO - PROCESS | 12931 | console.error: PushService: 02:43:04 INFO - PROCESS | 12931 | stateChangeProcessEnqueue: Error transitioning state 02:43:04 INFO - PROCESS | 12931 | UnknownError 02:43:04 INFO - TEST-INFO | 12931: exit 0 02:43:04 INFO - Browser initialized. 02:43:04 INFO - Running cycle 1/1 for dromaeo_css test... 02:43:04 INFO - TEST-INFO | started process 13024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ8uvix/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:16 INFO - PROCESS | 13024 | RSS: Main: 144531456 02:43:16 INFO - PROCESS | 13024 | 02:44:07 INFO - PROCESS | 13024 | 1482749047098 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:46:18 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:45610/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45610/tests/dromaeo/cssquery-ext.html) 02:46:20 INFO - PROCESS | 13024 | RSS: Main: 251322368 02:46:20 INFO - PROCESS | 13024 | 02:49:22 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:45610/tests/dromaeo/cssquery-ext.html (next: http://localhost:45610/tests/dromaeo/cssquery-jquery.html) 02:49:22 INFO - PROCESS | 13024 | RSS: Main: 233111552 02:49:22 INFO - PROCESS | 13024 | 02:52:24 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:45610/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45610/tests/dromaeo/cssquery-mootools.html) 02:52:25 INFO - PROCESS | 13024 | RSS: Main: 214523904 02:52:25 INFO - PROCESS | 13024 | 02:55:27 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:45610/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45610/tests/dromaeo/cssquery-prototype.html) 02:55:27 INFO - PROCESS | 13024 | RSS: Main: 221343744 02:55:27 INFO - PROCESS | 13024 | 02:58:30 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:45610/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45610/tests/dromaeo/cssquery-yui.html) 02:58:31 INFO - PROCESS | 13024 | RSS: Main: 175292416 02:58:31 INFO - PROCESS | 13024 | 03:01:33 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:45610/tests/dromaeo/cssquery-yui.html (next: http://localhost:45610/tests/dromaeo/cssquery-dojo.html) 03:01:34 INFO - PROCESS | 13024 | RSS: Main: 251510784 03:01:34 INFO - PROCESS | 13024 | 03:01:34 INFO - PROCESS | 13024 | __start_tp_report 03:01:34 INFO - PROCESS | 13024 | _x_x_mozilla_page_load 03:01:34 INFO - PROCESS | 13024 | _x_x_mozilla_page_load_details 03:01:34 INFO - PROCESS | 13024 | |i|pagename|runs| 03:01:34 INFO - PROCESS | 13024 | |0;dojo.html;3186.3945850288446;3228.741700663946;3235.530848027036;3262.478003519437;3272.3618894315605;5390.218418329345;5466.808661696841;5469.206964990084;5477.20580515825;5478.315210598676;5520.227168196456;5571.331440227168;5578.9163162552495;5584.46947539983;5595.720213989304;5039.067772462088;5058.317127187837;5082.593392528607;5085.974570127163;5152.458991805863;4965.0566392385335;5101.260317253996;5146.0479811235045;5153.742312884341;5154.716490593016;4943.604511639078;5012.122878496249;5049.495050494939;5071.974640126794;5078.873028174288;5091.338126043628;5120.257562653394;5121.590272778188;5174.741262936838;5189.299444574972;4853.854384368475;5072.416672082721;5098.980203959223;5134.486551344873;5137.48625137487;5427.810026649087;5439.0209762242785;5449.291592093042;5465.289512363367;5525.060739674265;5882.3529411764675;5919.6152250103605;5961.493273071794;5971.223740913653;5980.162777211151;5710.343310519302;5951.166836642873;5973.820785376446;5984.281886173687;5985.521158307369;5395.29861118056;5524.944750552523;5573.972130139324;5581.162825576115;5600.579956503197;6080.0575910733905;6082.118092876508;6084.087386891913;6085.69571521431;6085.817425477243;5694.857628559319;5844.298684157843;5845.678487683218;5857.15071314657;5857.7656893724625;5804.796832110856;5825.679587622637;5833.854153646193;5846.298444186725;5894.292684877756;5878;5879.617824841372;5888.3228428731245;5890.587658863838;5907.202527658797;5840.211571437886;5874;5884.0585506318785;5890.9410905891245;5892.911606325909;4543.159515489645;4579.38178345919;4605.0559635274685;4644.140833945731;4644.930326045112;4144.046869220097;4159.521655009652;4171.83312667496;4186.434831297735;4194.853180138681;5700.971495142498;5714.399988001283;5715.257016587817;5720.513756330759;5725.541956643542;5750.079987202028;5757.309122905278;5798.043322851682;5802.24570805801;5809.157672137601;5612.831615051555;5617.831465055973;5618.101103823368;5631.155326700946;5658.971705141448;5164.302819119371;5175.741212939338;5180.559652429586;5181.611379146579;5212.50481204285;6105.603135796159;6111.113888486145;6135.110179431455;6214.627122372672;6231.532635052389;5979.372165922689;5996.520278377632;5999.1601175836295;6002.249718785152;6013.248343957005;6099.9390006099375;6153.907691384543;6157.876842463215;6169.938300617116;6186.412290832363;5626.887462250814;5632.859178520406;5685.658860468385;5821.243238378984;5828.912566311424;5770.653760774367;5822.650640961556;5828.76684932598;5843.620164689281;5861.062230043172;5648.406917273627;5682.176084467646;5683.71581420919;5686.886262274814;5686.914696279642;5557.277553917965;5568.91646625309;5668.03643380618;5669.121286200645;5673.943260567342;5682.6306290091015;5724.055530837365;5761.711914404347;5805.8548536286935;5811.244538210006;5805.970970145122;5867.618604790675;5874.853128671646;5874.970625146847;5876.118582212703;5565.777368905198;5577.079781836114;5626.943730562642;5628.60599758013;5729.140628905698 03:01:34 INFO - PROCESS | 13024 | |1;ext.html;592.2034863109117;598.2611474828587;637.9776707815228;670.8389986403265;674.9021391898178;34361.484577731324;35169.47245791312;37688.24623507528;44732.77633611827;46201.768991155084;46536.76731616346;46919;46921.53078469214;47080.764596177054;47150.29274560876;8721.520316382597;8857.601407936627;8858.114188581154;8862.33532485063;8874.423162494417;8427.49435033897;8596.097409771977;8803.33974951878;8906.643734250621;10371.636992705256;10500.474976251195;10771.676849694522;10781.299215551004;10784;10792.838107428395;10571.73570660732;10635.680929572125;10642.680719578426;10644.520996555173;10645.57417703291;10509.949005099505;10510.78978420435;10558.577656893793;10571.62999295021;10575.101116405114;44232.557674423166;44456.77771611154;44501.777491112334;44595;44684.10631787346;3683.650053244937;3851.0372406898277;3891.2217556488818;3940.3695408734466;4424.845130420452;33176.83411582951;33244.833775831205;33634.49548256778;34823.30353392918;34927.301453971035;4455.420795296591;4458.152950939311;4536.909261814778;4542.114287713897;4698.506656801021;354153;355909;358593;358597;359354;60343.39656603466;60898.69550652307;60920.69539652362;60933.695331523944;60944;38960.805195974404;38982.80508597439;39658.60341396549;65175.348246517875;65460.67269663621;18127.365542206222;18597.535061623297;18602.534936626693;18657.720134197996;18668.81331186698;14575.635609109646;14664.560063198121;14671;14673.266336683337;14677.55967320982;18580.349687760863;18829.811701883078;19781.901090494743;20217.59564808725;20555.58888822215;7283.927160728431;7285.198628150899;7436.516626419266;7477;7611.619419029137;1026.0662796854976;1034.6689059501039;1139.1171841822488;1141.9143564232716;1150.3500522204927;33698.831505842805;34199.316013679585;34253.314933701186;34263.31473370569;34272.65727342694;1173.8708742038539;1189.970250743721;1239.9938000309942;1243.9875601244053;1258.6035398849333;17472.65054698899;17675.85106968043;17771.466855994084;17959.582465130676;17988.910055449902;147054;147163;147201;147905.2604736991;148398;61491.38508614946;62202.68898655478;62273.37726622676;62294.377056229765;62389;1372.9244891531062;1427.928603569838;1442.3004842651305;1443.3937746146644;1446.4503488674236;31264;32683;32801.34397312088;33083.50374744429;33218.50172247466;53435;53651.19523207077;53754.73122634518;53792.19311710249;53799.73100134474;435244;437816;437817;438452;438919;27189.320266993484;27225.591616125377;31076.68923310738;31469.685303146674;31565.368692625558;49041.26438103503;49425;49586.25620615621;53209.733951329996;54044.72977635244;41258;42425.78787106045;43272.134557309306;43813.56186438095;43874.78062609667;42246.155076898904;43320.70037898868;43372.34941475817;43762.12475750403;43953;43542.346864797684;44400;44602;44767.55232447634;44784.77607611941;36323.27353452969;38684.41973370346;39332.21335573215;39486.21027579375;39755;28461.288467788472;29443.263918402212;29878.70121298759;31185.688143118277;31235.53146702756 03:01:34 INFO - PROCESS | 13024 | |2;jquery.html;411.44454985769215;414.81748030866436;418.32022962685636;425.9893502662433;432.9004329004329;19546.413607591778;20019.699704504408;20219.191232350706;20639.896800516013;20913.790862091413;18453.44639660809;18682.159302831373;18711.438656840317;18846.623067538676;20259.797402025975;5710.257666503359;5912.497437717778;5942.465178133967;5944.613600115978;5951.464368206861;4190.120074784299;5115.360579927509;5770.134479828039;5848.795292164775;5849.151872978416;6483.481321494292;6606.075149479053;6607.801765947005;6609.834754131137;6612;6402.519811014169;6543.443807276387;6547.836304092388;6548.148740663731;6588.50586206034;5699.943000569982;5802.158686990405;5812.534997200214;5821.214136091616;5871.6183448075735;24066.398340041465;24400.755992440027;24509.509809803705;24514.632280515627;24832.255032349058;2385.7852793248517;2516.484120755241;2572.974270257292;2752.9538775265273;2757.54500507416;15080.622984425367;15080.924595376953;15204.16377099259;15244.466443674419;15694.52916412498;1905.1902941249914;1909.3412772593433;1912.7895931447529;1939.4763413878316;2025.402506260642;84537;86202.13797862067;86451.99999999937;87353.56323218407;89684;10681.771596266528;10822.783544329226;10911.399873007062;11011.449427528752;11332.546698132148;15487.148206848506;15726.842731572538;15803.841961580467;15836.129012904401;15862.841371586137;8771.473711577326;8831.470111793184;8896.5996530155;8906.198442140238;9001.054889236666;8802.471851688792;8802.691905783267;8830.381873268809;9011.684591039413;9016.143466370684;6856.348646878539;6882.621455819878;6920.723171073201;6947.548409353376;6975.4070903972715;1789.783078679545;1873.8500919926646;1992.8405727541763;2000.8599398042288;2029.1376165129761;1040.8107367844336;1059.862217911682;1099.115212254143;1100.2463312630873;1112.1158678850172;20249.29127480531;20370.388888333375;20720.44657511016;20759;20820.895895520425;1057.0644979193316;1072.5334479501441;1094.655183617158;1111.3831823338126;1171.1041053594008;11034.393108378956;11733.08285702872;11835.11236657237;11901.285922844658;11943.16397852142;426769;437245;445821;450256;453906;79360.6031969848;80001.59999200083;80355.59822200969;81091;84874;1042.6298663974333;1045.5347370420243;1047.3087762077146;1048.9318194317345;1052.2529004406804;17499.475015749547;17953.640927181645;18775.34286299973;18785.154668040243;18825.717614236073;39670.80164599159;40052.39921401123;40808.79595602003;41200.1759964805;41217.793911030254;53467.73266133644;55113.72443137759;55691;56050.43949560615;57157.714211428676;6798.966005169942;7673.386129109769;8109.959450202711;8515.872261915953;8635.438696484709;11736.70658233551;13239.735205296032;13282.203067815963;13719.245441500812;13854.376553054935;11300.886991129983;11737.178397512092;11824.1131915105;11954.76090478203;11970.341631210367;10389.324693894872;10564.841527376942;10956.233063685784;11650.48543689315;11716.882831171579;10763.784724305313;11184.433501465419;11224.494897729459;11359.716007099889;11374.260673056226;8159.224873636995;8295;8360.289375402916;8368.581570921308;8413.621387037476;9850.802983940137;9968.800623987625;10288.537015834156;10322.845157322796;10370.948145259226 03:01:34 INFO - PROCESS | 13024 | |3;mootools.html;1360.5578187089197;1461.254760072363;1516.1130738517968;1638.418361481674;1846.4829847642657;7858.921410785898;8253;8324.292435143012;8605.139486051392;8605.56972151393;8495.192956669121;8550.95724521378;8564.400491965565;8566.614502347395;8568.828623427544;2404.6152615581555;2431.720352159498;2432.343267317823;2434.6348047792885;2435.671184390111;2402.759724027592;2464.0636558107894;2475.418276704973;2476.6037434010564;2476.950460990779;2399.904003839853;2402.60357041088;2420.854748715074;2439.4145405102827;2440.1337525178574;2350.9294721158394;2370.5495955768433;2381.166591692911;2394.0543485323287;2396.305071529263;2384.4396566806786;2394.7246066702205;2414.3119211024773;2414.915477958263;2418.9516209675708;8825.779355516099;8995.865062024075;8996.730098097067;9004.324675649352;9008.549572521348;5394.433584473652;5562.276904002494;5571.387147413781;5644.758153206288;5658.490735833753;3347.071312601474;3440.8107554084513;3445.2937147884622;3497.930041399183;3512.4731290306404;1141.3988865130527;1142.7885841119419;1166.5158959032076;1196.3001644038247;1210.0622017936082;12426.751464970741;12459.750804983849;12470.75058498825;12518.874811251862;12568.371581420892;4414.27164517851;4705.835295764632;4737.692050016738;4738.123447162286;4761.666683332202;9774.51127443625;9774.951125244328;9782.461964591874;9790.51047447639;9814.312998090209;5444.3194600674915;5451.2640793493165;5455.18172274162;5456.099743542351;5466.945330546723;4249.553796851286;4303.978480107642;4515.277555591089;5092.898142037138;5114.744262786846;3855.6722678572637;3906.2968665639887;3975.6421922027157;4001.679865610744;4004.1591265833918;1226.8650448450662;1247.6880779805049;1253.4986005597834;1260.4958016793173;1261.1802328486374;998.9400635961865;1019.4453458475883;1026.4252018869456;1036.0778906772978;1041.422010784007;5861.618994765412;6021.277446706424;6176.227971503562;6252.530655296002;6417.197850268716;494.2141994229193;502.1488576862184;512.3390825834706;515.6361424033411;517.0383087457326;4202.873913782591;4314.460692413449;4322.222000040023;4342.522322544518;4376.606105450461;10188.490575471345;10494.632687855888;10529.157667386591;10537.63118290856;10637.042666160083;10405;10420.11429028541;10442.477876106317;10453.425061621683;10454.790904181873;8023.117457079717;8039.35685145187;8141.982252218472;8146.959265203636;8147.67409303633;5883.646981181143;5884.558658100574;5923.4076592340425;5958.136070269873;6024.307204671343;9593.664221752484;9637.903620963982;9647.662331818352;9668;9715.805683886425;9083.636654533744;9416.246700264099;10169.03394177552;10451.21615878797;10463.476826158814;6960.338767817049;7094.219635840157;7102.680379382837;7454.589997550187;7538.09542854861;8231.176882311722;8276.544790036605;8311.542865142475;8347.332213423033;8365.539895305817;7391.519551229153;7579.810504737426;7664.961675191811;7748.108967468813;7884.645190966306;7133.785986420416;7224.2053374129855;7366.742164024234;7468.141163766237;7542.622868856645;7286.817829554091;7447.180810110992;7495.775126746206;7502.587357695161;7524.736634217776;5297.8145764898045;5409.486098820606;5421.322334708161;5570.3315602128005;5593.384727680033;5339.3058902342445;5366.463353664602;5381.165919282517;5603.35561410443;5632.774689012557 03:01:34 INFO - PROCESS | 13024 | |4;prototype.html;338.0450228105602;347.5967877262376;349.040139616056;349.60145434205003;351.08717334929185;5387.892242155154;5389.299391079159;5396.1905714142895;5412.134058550632;5420.647657902244;5100.209467532529;5153.30430391897;5245.973770131144;5293.52358287754;5338.078291814943;4174.394712766647;4200.96253317141;4225.915481690365;4228.302330115543;4228.386883901832;4164.604362585565;4228.830846766125;4233.661307095425;4234.470691163605;4243.681723870706;3915.451836742858;3925.607439256066;4158.4594002779595;4182.435371224876;4223.767692776896;4139.937900931488;4147.3778933159965;4168.145530166309;4171.811033855367;4194.454720886296;3722.088088418328;3730.5336832895887;3737.458068580068;3743.1016556026357;3750.2124553843723;5099.33708617881;5118.513741194581;5148.819791307324;5260.210968354778;5274.841754747364;4701;4712.387389639359;4729.858104256878;4732.83435079774;4737.881552961169;5476;5490.69801160936;5518.779248830042;5520.861978450531;5522.22688823565;3927.3912543555793;4084.877453676365;4093.385992101179;4119.691023173274;4148.91702165958;5646.830595082154;5654.349749778787;5677.744501497401;5690.5447564194765;5693.629914055615;4118.361653943643;4155.688323375698;4157;4164.271252530795;4177.8328866845595;3957.52509698838;4118.238125946709;4268.271350103213;4269.701120921568;4273.1240095780295;4687.671862969628;4698.342232087511;4702.811887524529;4720.645951553579;4746.572808447257;5511.724413779295;5522;5526.171074338801;5598.552115830724;5602.915956260659;1353.7698591239514;1384.494659449314;1395.771720885614;1398.1331574423923;1406.585057408067;922.3220932614523;922.7554698005034;940.2478017585904;941.2987324443196;953.9570719317647;5270.841874743764;5280.683159010472;5305.708186049805;5333.733313334318;5391.110466772939;5438.021156191923;5452.345718513804;5496.31296087989;5516.531094856902;5521.365043020024;5194.714290714047;5267.604929630293;5537.556995440355;5544.86137846549;5584.21820945068;2913.490139225627;2924.4297362014204;2926.9268268293035;2944.36696110333;2960.2155428811384;5670.319561652628;5761.769529218785;5812.936407575335;5871.500922421642;5893.5560787606455;5583.469570390806;5585.888282234332;5616.623927137795;5628.690422026746;5629.493345598916;5811.331696854916;5811.622244554091;5817.185594016925;5819.883602328015;5878.941210587925;5214.843554693365;5441.238226648194;5458.2904222450825;5486.588505862156;5493.807716729895;5448.482394172547;5448.991936491761;5454.945450545444;5489.917651235314;5497.36780270274;5592.3715853548765;5867.9413205867395;5875.559333050124;5893.9371220072635;5921.111833225051;3970.974802850509;4004.9386912468804;4020.3567429211184;4023.4970628671417;4028.637422631977;5519.172124181245;5541.473560011793;5551.361593416808;5586.38549759518;5635.5203710367305;5276.762545685377;5401.154422566198;5454.972725136349;5509.586780991362;5533.6403133796175;5334.866628334323;5361;5370.677759334452;5385.8114965976;5389.757460914347;5297.417284098823;5303.568036630166;5335.253064570886;5338.024930775638;5432.538234250133;5471.616986811045;5566.304211973504;5573.27547418833;5580.023495888285;5583.581231407742;5444.754986025559;5448.809291674773;5453.15476101205;5454.863628409322;5502.779888804403 03:01:34 INFO - PROCESS | 13024 | |5;yui.html;772.5133166105354;795.5028107432854;798.4690181029615;839.8194388206537;888.1340692824493;14394.712105757892;15097.698046039086;15986.12076335801;16032.59918502038;16039.03765774053;14163.504277350296;14259.001869869113;14539.200343981103;14540.418383264656;14552.708945821078;839.1566475691936;847.1232274595794;847.8050048488851;848.4442690038035;849.5921957460423;727.4725823777771;749.5352881213655;841.8148007438353;870.2298465857698;875.689130358723;918.3525614441802;920.3281604428771;920.4063379120497;920.5765347939956;921.1985572551856;906.5150144672568;917.7797328641111;917.9908200917972;918.8851393575803;919.5172534419416;558.8463172627519;572.2246356187347;633.9936600634027;644.1207751419325;648.4261428635645;14892.404303827941;14938.103713777207;14975.400983960628;15033.924830375887;15050.172240526766;13672.794908076386;14025.43898244069;14190.43238270468;14250.2162381069;14311.069780464237;12778.872211277954;12810.42353094113;12852.293123878182;12958.48166073356;13073.673158171026;4205.285101532747;4252.659787217015;4281.529031806499;4313.762743049131;4358.4769827620885;57849.42150578524;59723.402765972656;59840.700796496174;61684;61695;11604.361760103275;11693.415329233505;11839.467223974942;11911.166218364804;12119.575814846614;20682.68975965362;20844.06201720926;20855;20886.373408797455;21038.158473661188;7617.695292188361;7654.387648988068;7778.92221077782;7792.961035194788;8360.45657032291;4718.598919091847;4725.976370118127;4741.857744267678;4823.807047718122;4863.367762190893;3299.769016168845;3384;3384.2047118927035;3392.2028323343993;3402.166469215058;612.1766224428137;629.6568370238231;634.0267689097213;635.3963734452196;635.4503354598331;540.2139886465184;586.7711592478852;624.1979056911937;650.4146268358515;675.5743881354715;7735.131552060041;8089.393295502743;8310.792230194173;8345.582720863933;8850.159234872677;572.5362456410321;580.2630659062967;585.2771826793906;683.5112894280513;702.3854127638316;4477.552244775497;4505.774711264424;4598.218302888517;4689.6248300136585;4714.198586240347;88283;94456;97035.0296497026;97485;100172.4991375053;55538.72230638821;65873.34126658768;73124;85152;86780;43075.35386969198;43184.352234716505;46263.768681156376;63289.68355158195;69097.65451172712;8432.367572432215;8831.470111793313;8871.778205544913;8986.910130898606;9172.770680733034;35006.82496587501;36423.45364819583;42211;43986.34020489759;47591;55943;56713.716431417575;56790;57505.13742293953;58279.4172058274;12668.303243321338;12831.230126192459;13030.087893847718;13323.467061317438;13613.387397566936;13749.175049497062;13953;14412.495562655256;14420.783688244894;14454.205018724071;13485.865141348853;13652;13802.17186968785;14096.929515352358;14572.781408278672;12628.494860205488;12650;13123.737525249251;13324.933375333061;13552.796708049584;12321.322327271728;12630.684232894251;12656.17734847232;13016.934915325362;13333.53332633392;9716.611335546782;9759.316847820868;9762.121409073217;9784.9021509784;9976.50117494137;9795.706128816148;10432.530536125741;10534.157267418741;10572.84140737874;10693.358398496115 03:01:34 INFO - PROCESS | 13024 | __end_tp_report 03:01:34 INFO - PROCESS | 13024 | __start_cc_report 03:01:34 INFO - PROCESS | 13024 | _x_x_mozilla_cycle_collect,1100 03:01:34 INFO - PROCESS | 13024 | __end_cc_report 03:01:34 INFO - PROCESS | 13024 | __startTimestamp1482750094090__endTimestamp 03:01:34 INFO - PROCESS | 13024 | 03:01:34 INFO - PROCESS | 13024 | ------- Summary: start ------- 03:01:34 INFO - PROCESS | 13024 | Number of tests: 6 03:01:34 INFO - PROCESS | 13024 | 03:01:34 INFO - PROCESS | 13024 | [#0] dojo.html Cycles:165 Average:5501.19 Median:5682.18 stddev:595.72 (10.5%) stddev-sans-first:569.19 03:01:34 INFO - PROCESS | 13024 | Values: 3186.4 3228.7 3235.5 3262.5 3272.4 5390.2 5466.8 5469.2 5477.2 5478.3 5520.2 5571.3 5578.9 5584.5 5595.7 5039.1 5058.3 5082.6 5086.0 5152.5 4965.1 5101.3 5146.0 5153.7 5154.7 4943.6 5012.1 5049.5 5072.0 5078.9 5091.3 5120.3 5121.6 5174.7 5189.3 4853.9 5072.4 5099.0 5134.5 5137.5 5427.8 5439.0 5449.3 5465.3 5525.1 5882.4 5919.6 5961.5 5971.2 5980.2 5710.3 5951.2 5973.8 5984.3 5985.5 5395.3 5524.9 5574.0 5581.2 5600.6 6080.1 6082.1 6084.1 6085.7 6085.8 5694.9 5844.3 5845.7 5857.2 5857.8 5804.8 5825.7 5833.9 5846.3 5894.3 5878.0 5879.6 5888.3 5890.6 5907.2 5840.2 5874.0 5884.1 5890.9 5892.9 4543.2 4579.4 4605.1 4644.1 4644.9 4144.0 4159.5 4171.8 4186.4 4194.9 5701.0 5714.4 5715.3 5720.5 5725.5 5750.1 5757.3 5798.0 5802.2 5809.2 5612.8 5617.8 5618.1 5631.2 5659.0 5164.3 5175.7 5180.6 5181.6 5212.5 6105.6 6111.1 6135.1 6214.6 6231.5 5979.4 5996.5 5999.2 6002.2 6013.2 6099.9 6153.9 6157.9 6169.9 6186.4 5626.9 5632.9 5685.7 5821.2 5828.9 5770.7 5822.7 5828.8 5843.6 5861.1 5648.4 5682.2 5683.7 5686.9 5686.9 5557.3 5568.9 5668.0 5669.1 5673.9 5682.6 5724.1 5761.7 5805.9 5811.2 5806.0 5867.6 5874.9 5875.0 5876.1 5565.8 5577.1 5626.9 5628.6 5729.1 03:01:34 INFO - PROCESS | 13024 | 03:01:34 INFO - PROCESS | 13024 | [#1] ext.html Cycles:180 Average:50592.98 Median:20769.64 stddev:89149.19 (429.2%) stddev-sans-first:89320.23 03:01:34 INFO - PROCESS | 13024 | Values: 592.2 598.3 638.0 670.8 674.9 34361.5 35169.5 37688.2 44732.8 46201.8 46536.8 46919.0 46921.5 47080.8 47150.3 8721.5 8857.6 8858.1 8862.3 8874.4 8427.5 8596.1 8803.3 8906.6 10371.6 10500.5 10771.7 10781.3 10784.0 10792.8 10571.7 10635.7 10642.7 10644.5 10645.6 10509.9 10510.8 10558.6 10571.6 10575.1 44232.6 44456.8 44501.8 44595.0 44684.1 3683.7 3851.0 3891.2 3940.4 4424.8 33176.8 33244.8 33634.5 34823.3 34927.3 4455.4 4458.2 4536.9 4542.1 4698.5 354153.0 355909.0 358593.0 358597.0 359354.0 60343.4 60898.7 60920.7 60933.7 60944.0 38960.8 38982.8 39658.6 65175.3 65460.7 18127.4 18597.5 18602.5 18657.7 18668.8 14575.6 14664.6 14671.0 14673.3 14677.6 18580.3 18829.8 19781.9 20217.6 20555.6 7283.9 7285.2 7436.5 7477.0 7611.6 1026.1 1034.7 1139.1 1141.9 1150.4 33698.8 34199.3 34253.3 34263.3 34272.7 1173.9 1190.0 1240.0 1244.0 1258.6 17472.7 17675.9 17771.5 17959.6 17988.9 147054.0 147163.0 147201.0 147905.3 148398.0 61491.4 62202.7 62273.4 62294.4 62389.0 1372.9 1427.9 1442.3 1443.4 1446.5 31264.0 32683.0 32801.3 33083.5 33218.5 53435.0 53651.2 53754.7 53792.2 53799.7 435244.0 437816.0 437817.0 438452.0 438919.0 27189.3 27225.6 31076.7 31469.7 31565.4 49041.3 49425.0 49586.3 53209.7 54044.7 41258.0 42425.8 43272.1 43813.6 43874.8 42246.2 43320.7 43372.3 43762.1 43953.0 43542.3 44400.0 44602.0 44767.6 44784.8 36323.3 38684.4 39332.2 39486.2 39755.0 28461.3 29443.3 29878.7 31185.7 31235.5 03:01:34 INFO - PROCESS | 13024 | 03:01:34 INFO - PROCESS | 13024 | [#2] jquery.html Cycles:180 Average:27826.37 Median:24455.13 stddev:73085.50 (298.9%) stddev-sans-first:73261.54 03:01:34 INFO - PROCESS | 13024 | Values: 411.4 414.8 418.3 426.0 432.9 19546.4 20019.7 20219.2 20639.9 20913.8 18453.4 18682.2 18711.4 18846.6 20259.8 5710.3 5912.5 5942.5 5944.6 5951.5 4190.1 5115.4 5770.1 5848.8 5849.2 6483.5 6606.1 6607.8 6609.8 6612.0 6402.5 6543.4 6547.8 6548.1 6588.5 5699.9 5802.2 5812.5 5821.2 5871.6 24066.4 24400.8 24509.5 24514.6 24832.3 2385.8 2516.5 2573.0 2753.0 2757.5 15080.6 15080.9 15204.2 15244.5 15694.5 1905.2 1909.3 1912.8 1939.5 2025.4 84537.0 86202.1 86452.0 87353.6 89684.0 10681.8 10822.8 10911.4 11011.4 11332.5 15487.1 15726.8 15803.8 15836.1 15862.8 8771.5 8831.5 8896.6 8906.2 9001.1 8802.5 8802.7 8830.4 9011.7 9016.1 6856.3 6882.6 6920.7 6947.5 6975.4 1789.8 1873.9 1992.8 2000.9 2029.1 1040.8 1059.9 1099.1 1100.2 1112.1 20249.3 20370.4 20720.4 20759.0 20820.9 1057.1 1072.5 1094.7 1111.4 1171.1 11034.4 11733.1 11835.1 11901.3 11943.2 426769.0 437245.0 445821.0 450256.0 453906.0 79360.6 80001.6 80355.6 81091.0 84874.0 1042.6 1045.5 1047.3 1048.9 1052.3 17499.5 17953.6 18775.3 18785.2 18825.7 39670.8 40052.4 40808.8 41200.2 41217.8 53467.7 55113.7 55691.0 56050.4 57157.7 6799.0 7673.4 8110.0 8515.9 8635.4 11736.7 13239.7 13282.2 13719.2 13854.4 11300.9 11737.2 11824.1 11954.8 11970.3 10389.3 10564.8 10956.2 11650.5 11716.9 10763.8 11184.4 11224.5 11359.7 11374.3 8159.2 8295.0 8360.3 8368.6 8413.6 9850.8 9968.8 10288.5 10322.8 10370.9 03:01:34 INFO - PROCESS | 13024 | 03:01:34 INFO - PROCESS | 13024 | [#3] mootools.html Cycles:180 Average:5760.07 Median:516.34 stddev:3193.30 (618.5%) stddev-sans-first:3185.14 03:01:34 INFO - PROCESS | 13024 | Values: 1360.6 1461.3 1516.1 1638.4 1846.5 7858.9 8253.0 8324.3 8605.1 8605.6 8495.2 8551.0 8564.4 8566.6 8568.8 2404.6 2431.7 2432.3 2434.6 2435.7 2402.8 2464.1 2475.4 2476.6 2477.0 2399.9 2402.6 2420.9 2439.4 2440.1 2350.9 2370.5 2381.2 2394.1 2396.3 2384.4 2394.7 2414.3 2414.9 2419.0 8825.8 8995.9 8996.7 9004.3 9008.5 5394.4 5562.3 5571.4 5644.8 5658.5 3347.1 3440.8 3445.3 3497.9 3512.5 1141.4 1142.8 1166.5 1196.3 1210.1 12426.8 12459.8 12470.8 12518.9 12568.4 4414.3 4705.8 4737.7 4738.1 4761.7 9774.5 9775.0 9782.5 9790.5 9814.3 5444.3 5451.3 5455.2 5456.1 5466.9 4249.6 4304.0 4515.3 5092.9 5114.7 3855.7 3906.3 3975.6 4001.7 4004.2 1226.9 1247.7 1253.5 1260.5 1261.2 998.9 1019.4 1026.4 1036.1 1041.4 5861.6 6021.3 6176.2 6252.5 6417.2 494.2 502.1 512.3 515.6 517.0 4202.9 4314.5 4322.2 4342.5 4376.6 10188.5 10494.6 10529.2 10537.6 10637.0 10405.0 10420.1 10442.5 10453.4 10454.8 8023.1 8039.4 8142.0 8147.0 8147.7 5883.6 5884.6 5923.4 5958.1 6024.3 9593.7 9637.9 9647.7 9668.0 9715.8 9083.6 9416.2 10169.0 10451.2 10463.5 6960.3 7094.2 7102.7 7454.6 7538.1 8231.2 8276.5 8311.5 8347.3 8365.5 7391.5 7579.8 7665.0 7748.1 7884.6 7133.8 7224.2 7366.7 7468.1 7542.6 7286.8 7447.2 7495.8 7502.6 7524.7 5297.8 5409.5 5421.3 5570.3 5593.4 5339.3 5366.5 5381.2 5603.4 5632.8 03:01:34 INFO - PROCESS | 13024 | 03:01:34 INFO - PROCESS | 13024 | [#4] prototype.html Cycles:180 Average:4647.75 Median:5336.64 stddev:1344.83 (25.2%) stddev-sans-first:1309.12 03:01:34 INFO - PROCESS | 13024 | Values: 338.0 347.6 349.0 349.6 351.1 5387.9 5389.3 5396.2 5412.1 5420.6 5100.2 5153.3 5246.0 5293.5 5338.1 4174.4 4201.0 4225.9 4228.3 4228.4 4164.6 4228.8 4233.7 4234.5 4243.7 3915.5 3925.6 4158.5 4182.4 4223.8 4139.9 4147.4 4168.1 4171.8 4194.5 3722.1 3730.5 3737.5 3743.1 3750.2 5099.3 5118.5 5148.8 5260.2 5274.8 4701.0 4712.4 4729.9 4732.8 4737.9 5476.0 5490.7 5518.8 5520.9 5522.2 3927.4 4084.9 4093.4 4119.7 4148.9 5646.8 5654.3 5677.7 5690.5 5693.6 4118.4 4155.7 4157.0 4164.3 4177.8 3957.5 4118.2 4268.3 4269.7 4273.1 4687.7 4698.3 4702.8 4720.6 4746.6 5511.7 5522.0 5526.2 5598.6 5602.9 1353.8 1384.5 1395.8 1398.1 1406.6 922.3 922.8 940.2 941.3 954.0 5270.8 5280.7 5305.7 5333.7 5391.1 5438.0 5452.3 5496.3 5516.5 5521.4 5194.7 5267.6 5537.6 5544.9 5584.2 2913.5 2924.4 2926.9 2944.4 2960.2 5670.3 5761.8 5812.9 5871.5 5893.6 5583.5 5585.9 5616.6 5628.7 5629.5 5811.3 5811.6 5817.2 5819.9 5878.9 5214.8 5441.2 5458.3 5486.6 5493.8 5448.5 5449.0 5454.9 5489.9 5497.4 5592.4 5867.9 5875.6 5893.9 5921.1 3971.0 4004.9 4020.4 4023.5 4028.6 5519.2 5541.5 5551.4 5586.4 5635.5 5276.8 5401.2 5455.0 5509.6 5533.6 5334.9 5361.0 5370.7 5385.8 5389.8 5297.4 5303.6 5335.3 5338.0 5432.5 5471.6 5566.3 5573.3 5580.0 5583.6 5444.8 5448.8 5453.2 5454.9 5502.8 03:01:34 INFO - PROCESS | 13024 | 03:01:34 INFO - PROCESS | 13024 | [#5] yui.html Cycles:180 Average:17240.11 Median:26207.40 stddev:22708.97 (86.7%) stddev-sans-first:22739.01 03:01:34 INFO - PROCESS | 13024 | Values: 772.5 795.5 798.5 839.8 888.1 14394.7 15097.7 15986.1 16032.6 16039.0 14163.5 14259.0 14539.2 14540.4 14552.7 839.2 847.1 847.8 848.4 849.6 727.5 749.5 841.8 870.2 875.7 918.4 920.3 920.4 920.6 921.2 906.5 917.8 918.0 918.9 919.5 558.8 572.2 634.0 644.1 648.4 14892.4 14938.1 14975.4 15033.9 15050.2 13672.8 14025.4 14190.4 14250.2 14311.1 12778.9 12810.4 12852.3 12958.5 13073.7 4205.3 4252.7 4281.5 4313.8 4358.5 57849.4 59723.4 59840.7 61684.0 61695.0 11604.4 11693.4 11839.5 11911.2 12119.6 20682.7 20844.1 20855.0 20886.4 21038.2 7617.7 7654.4 7778.9 7793.0 8360.5 4718.6 4726.0 4741.9 4823.8 4863.4 3299.8 3384.0 3384.2 3392.2 3402.2 612.2 629.7 634.0 635.4 635.5 540.2 586.8 624.2 650.4 675.6 7735.1 8089.4 8310.8 8345.6 8850.2 572.5 580.3 585.3 683.5 702.4 4477.6 4505.8 4598.2 4689.6 4714.2 88283.0 94456.0 97035.0 97485.0 100172.5 55538.7 65873.3 73124.0 85152.0 86780.0 43075.4 43184.4 46263.8 63289.7 69097.7 8432.4 8831.5 8871.8 8986.9 9172.8 35006.8 36423.5 42211.0 43986.3 47591.0 55943.0 56713.7 56790.0 57505.1 58279.4 12668.3 12831.2 13030.1 13323.5 13613.4 13749.2 13953.0 14412.5 14420.8 14454.2 13485.9 13652.0 13802.2 14096.9 14572.8 12628.5 12650.0 13123.7 13324.9 13552.8 12321.3 12630.7 12656.2 13016.9 13333.5 9716.6 9759.3 9762.1 9784.9 9976.5 9795.7 10432.5 10534.2 10572.8 10693.4 03:01:34 INFO - PROCESS | 13024 | -------- Summary: end -------- 03:01:34 INFO - PROCESS | 13024 | 03:01:34 INFO - TEST-INFO | 13024: exit 0 03:01:34 INFO - TEST-OK | dromaeo_css | took 1115210ms 03:01:34 INFO - TEST-START | kraken 03:01:34 INFO - operating with platform_type : linux_ 03:01:34 INFO - Initialising browser for kraken test... 03:01:34 INFO - TEST-INFO | started process 13337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVZKCnb/profile http://localhost:45610/getInfo.html) 03:01:38 INFO - PROCESS | 13337 | __metrics Screen width/height:1600/1200 03:01:38 INFO - PROCESS | 13337 | colorDepth:24 03:01:38 INFO - PROCESS | 13337 | Browser inner width/height: 1024/697 03:01:38 INFO - PROCESS | 13337 | __metrics 03:01:38 INFO - PROCESS | 13337 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:01:38 INFO - PROCESS | 13337 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:01:39 INFO - PROCESS | 13337 | console.error: PushService: 03:01:39 INFO - PROCESS | 13337 | stateChangeProcessEnqueue: Error transitioning state 03:01:39 INFO - PROCESS | 13337 | UnknownError 03:01:39 INFO - TEST-INFO | 13337: exit 0 03:01:39 INFO - Browser initialized. 03:01:39 INFO - Running cycle 1/1 for kraken test... 03:01:39 INFO - TEST-INFO | started process 13430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVZKCnb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:51 INFO - PROCESS | 13430 | RSS: Main: 144093184 03:01:51 INFO - PROCESS | 13430 | 03:01:54 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45610/tests/kraken/driver.html?testName=audio-beat-detection) 03:01:55 INFO - PROCESS | 13430 | RSS: Main: 185741312 03:01:55 INFO - PROCESS | 13430 | 03:01:57 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45610/tests/kraken/driver.html?testName=audio-dft) 03:01:58 INFO - PROCESS | 13430 | RSS: Main: 175050752 03:01:58 INFO - PROCESS | 13430 | 03:02:01 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45610/tests/kraken/driver.html?testName=audio-fft) 03:02:01 INFO - PROCESS | 13430 | RSS: Main: 266792960 03:02:01 INFO - PROCESS | 13430 | 03:02:03 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45610/tests/kraken/driver.html?testName=audio-oscillator) 03:02:04 INFO - PROCESS | 13430 | RSS: Main: 172748800 03:02:04 INFO - PROCESS | 13430 | 03:02:06 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45610/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:02:07 INFO - PROCESS | 13430 | RSS: Main: 175116288 03:02:07 INFO - PROCESS | 13430 | 03:02:09 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45610/tests/kraken/driver.html?testName=imaging-darkroom) 03:02:10 INFO - PROCESS | 13430 | RSS: Main: 214360064 03:02:10 INFO - PROCESS | 13430 | 03:02:13 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45610/tests/kraken/driver.html?testName=imaging-desaturate) 03:02:14 INFO - PROCESS | 13430 | RSS: Main: 213188608 03:02:14 INFO - PROCESS | 13430 | 03:02:17 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45610/tests/kraken/driver.html?testName=json-parse-financial) 03:02:17 INFO - PROCESS | 13430 | RSS: Main: 211480576 03:02:17 INFO - PROCESS | 13430 | 03:02:19 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45610/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:02:19 INFO - PROCESS | 13430 | RSS: Main: 173875200 03:02:19 INFO - PROCESS | 13430 | 03:02:21 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45610/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:02:22 INFO - PROCESS | 13430 | RSS: Main: 180797440 03:02:22 INFO - PROCESS | 13430 | 03:02:24 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45610/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:02:24 INFO - PROCESS | 13430 | RSS: Main: 189616128 03:02:24 INFO - PROCESS | 13430 | 03:02:27 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:02:27 INFO - PROCESS | 13430 | RSS: Main: 198889472 03:02:27 INFO - PROCESS | 13430 | 03:02:30 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:02:31 INFO - PROCESS | 13430 | RSS: Main: 194502656 03:02:31 INFO - PROCESS | 13430 | 03:02:32 INFO - PROCESS | 13430 | Cycle 1(1): loaded http://localhost:45610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45610/tests/kraken/driver.html?testName=ai-astar) 03:02:33 INFO - PROCESS | 13430 | RSS: Main: 245866496 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | __start_tp_report 03:02:33 INFO - PROCESS | 13430 | _x_x_mozilla_page_load 03:02:33 INFO - PROCESS | 13430 | _x_x_mozilla_page_load_details 03:02:33 INFO - PROCESS | 13430 | |i|pagename|runs| 03:02:33 INFO - PROCESS | 13430 | |0;ai-astar;103;114;112;112;112;112;112;111;113;111 03:02:33 INFO - PROCESS | 13430 | |1;audio-beat-detection;146;120;118;159;122;118;120;118;148;123 03:02:33 INFO - PROCESS | 13430 | |2;audio-dft;163;162;161;161;160;162;162;161;160;161 03:02:33 INFO - PROCESS | 13430 | |3;audio-fft;75;76;77;109;76;76;75;76;96;76 03:02:33 INFO - PROCESS | 13430 | |4;audio-oscillator;82;83;126;81;82;82;98;83;83;107 03:02:33 INFO - PROCESS | 13430 | |5;imaging-gaussian-blur;117;117;117;117;116;116;118;117;117;116 03:02:33 INFO - PROCESS | 13430 | |6;imaging-darkroom;146;145;145;146;146;145;146;146;146;146 03:02:33 INFO - PROCESS | 13430 | |7;imaging-desaturate;84;85;85;85;84;85;84;84;85;85 03:02:33 INFO - PROCESS | 13430 | |8;json-parse-financial;48;48;49;49;49;50;51;50;59;52 03:02:33 INFO - PROCESS | 13430 | |9;json-stringify-tinderbox;58;58;58;59;59;58;58;59;58;57 03:02:33 INFO - PROCESS | 13430 | |10;stanford-crypto-aes;75;75;77;74;75;75;74;75;77;75 03:02:33 INFO - PROCESS | 13430 | |11;stanford-crypto-ccm;122;122;123;121;121;120;120;119;170;127 03:02:33 INFO - PROCESS | 13430 | |12;stanford-crypto-pbkdf2;155;155;155;152;151;152;158;155;152;152 03:02:33 INFO - PROCESS | 13430 | |13;stanford-crypto-sha256-iterative;65;62;62;61;60;63;60;62;61;63 03:02:33 INFO - PROCESS | 13430 | __end_tp_report 03:02:33 INFO - PROCESS | 13430 | __start_cc_report 03:02:33 INFO - PROCESS | 13430 | _x_x_mozilla_cycle_collect,1590 03:02:33 INFO - PROCESS | 13430 | __end_cc_report 03:02:33 INFO - PROCESS | 13430 | __startTimestamp1482750153078__endTimestamp 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | ------- Summary: start ------- 03:02:33 INFO - PROCESS | 13430 | Number of tests: 14 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.01 (2.7%) stddev-sans-first:0.93 03:02:33 INFO - PROCESS | 13430 | Values: 103.0 114.0 112.0 112.0 112.0 112.0 112.0 111.0 113.0 111.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:122.50 stddev:15.49 (12.6%) stddev-sans-first:15.19 03:02:33 INFO - PROCESS | 13430 | Values: 146.0 120.0 118.0 159.0 122.0 118.0 120.0 118.0 148.0 123.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 03:02:33 INFO - PROCESS | 13430 | Values: 163.0 162.0 161.0 161.0 160.0 162.0 162.0 161.0 160.0 161.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:11.65 (15.3%) stddev-sans-first:12.14 03:02:33 INFO - PROCESS | 13430 | Values: 75.0 76.0 77.0 109.0 76.0 76.0 75.0 76.0 96.0 76.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.50 stddev:15.14 (18.4%) stddev-sans-first:15.73 03:02:33 INFO - PROCESS | 13430 | Values: 82.0 83.0 126.0 81.0 82.0 82.0 98.0 83.0 83.0 107.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 03:02:33 INFO - PROCESS | 13430 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 118.0 117.0 117.0 116.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:02:33 INFO - PROCESS | 13430 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 03:02:33 INFO - PROCESS | 13430 | Values: 84.0 85.0 85.0 85.0 84.0 85.0 84.0 84.0 85.0 85.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.00 stddev:3.24 (6.5%) stddev-sans-first:3.31 03:02:33 INFO - PROCESS | 13430 | Values: 48.0 48.0 49.0 49.0 49.0 50.0 51.0 50.0 59.0 52.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 03:02:33 INFO - PROCESS | 13430 | Values: 58.0 58.0 58.0 59.0 59.0 58.0 58.0 59.0 58.0 57.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:1.03 (1.4%) stddev-sans-first:1.09 03:02:33 INFO - PROCESS | 13430 | Values: 75.0 75.0 77.0 74.0 75.0 75.0 74.0 75.0 77.0 75.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:122.00 stddev:15.44 (12.7%) stddev-sans-first:16.29 03:02:33 INFO - PROCESS | 13430 | Values: 122.0 122.0 123.0 121.0 121.0 120.0 120.0 119.0 170.0 127.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:155.00 stddev:2.21 (1.4%) stddev-sans-first:2.30 03:02:33 INFO - PROCESS | 13430 | Values: 155.0 155.0 155.0 152.0 151.0 152.0 158.0 155.0 152.0 152.0 03:02:33 INFO - PROCESS | 13430 | 03:02:33 INFO - PROCESS | 13430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.52 (2.5%) stddev-sans-first:1.13 03:02:33 INFO - PROCESS | 13430 | Values: 65.0 62.0 62.0 61.0 60.0 63.0 60.0 62.0 61.0 63.0 03:02:33 INFO - PROCESS | 13430 | -------- Summary: end -------- 03:02:33 INFO - PROCESS | 13430 | 03:02:34 INFO - TEST-INFO | 13430: exit 0 03:02:34 INFO - TEST-OK | kraken | took 59363ms 03:02:34 INFO - SUITE-END | took 1174s 03:02:34 INFO - Completed test suite (00:19:34) 03:02:34 INFO - javascript benchmark 03:02:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3186.3945850288446, 3228.741700663946, 3235.530848027036, 3262.478003519437, 3272.3618894315605, 5390.218418329345, 5466.808661696841, 5469.206964990084, 5477.20580515825, 5478.315210598676, 5520.227168196456, 5571.331440227168, 5578.9163162552495, 5584.46947539983, 5595.720213989304, 5039.067772462088, 5058.317127187837, 5082.593392528607, 5085.974570127163, 5152.458991805863, 4965.0566392385335, 5101.260317253996, 5146.0479811235045, 5153.742312884341, 5154.716490593016, 4943.604511639078, 5012.122878496249, 5049.495050494939, 5071.974640126794, 5078.873028174288, 5091.338126043628, 5120.257562653394, 5121.590272778188, 5174.741262936838, 5189.299444574972, 4853.854384368475, 5072.416672082721, 5098.980203959223, 5134.486551344873, 5137.48625137487, 5427.810026649087, 5439.0209762242785, 5449.291592093042, 5465.289512363367, 5525.060739674265, 5882.3529411764675, 5919.6152250103605, 5961.493273071794, 5971.223740913653, 5980.162777211151, 5710.343310519302, 5951.166836642873, 5973.820785376446, 5984.281886173687, 5985.521158307369, 5395.29861118056, 5524.944750552523, 5573.972130139324, 5581.162825576115, 5600.579956503197, 6080.0575910733905, 6082.118092876508, 6084.087386891913, 6085.69571521431, 6085.817425477243, 5694.857628559319, 5844.298684157843, 5845.678487683218, 5857.15071314657, 5857.7656893724625, 5804.796832110856, 5825.679587622637, 5833.854153646193, 5846.298444186725, 5894.292684877756, 5878.0, 5879.617824841372, 5888.3228428731245, 5890.587658863838, 5907.202527658797, 5840.211571437886, 5874.0, 5884.0585506318785, 5890.9410905891245, 5892.911606325909, 4543.159515489645, 4579.38178345919, 4605.0559635274685, 4644.140833945731, 4644.930326045112, 4144.046869220097, 4159.521655009652, 4171.83312667496, 4186.434831297735, 4194.853180138681, 5700.971495142498, 5714.399988001283, 5715.257016587817, 5720.513756330759, 5725.541956643542, 5750.079987202028, 5757.309122905278, 5798.043322851682, 5802.24570805801, 5809.157672137601, 5612.831615051555, 5617.831465055973, 5618.101103823368, 5631.155326700946, 5658.971705141448, 5164.302819119371, 5175.741212939338, 5180.559652429586, 5181.611379146579, 5212.50481204285, 6105.603135796159, 6111.113888486145, 6135.110179431455, 6214.627122372672, 6231.532635052389, 5979.372165922689, 5996.520278377632, 5999.1601175836295, 6002.249718785152, 6013.248343957005, 6099.9390006099375, 6153.907691384543, 6157.876842463215, 6169.938300617116, 6186.412290832363, 5626.887462250814, 5632.859178520406, 5685.658860468385, 5821.243238378984, 5828.912566311424, 5770.653760774367, 5822.650640961556, 5828.76684932598, 5843.620164689281, 5861.062230043172, 5648.406917273627, 5682.176084467646, 5683.71581420919, 5686.886262274814, 5686.914696279642, 5557.277553917965, 5568.91646625309, 5668.03643380618, 5669.121286200645, 5673.943260567342, 5682.6306290091015, 5724.055530837365, 5761.711914404347, 5805.8548536286935, 5811.244538210006, 5805.970970145122, 5867.618604790675, 5874.853128671646, 5874.970625146847, 5876.118582212703, 5565.777368905198, 5577.079781836114, 5626.943730562642, 5628.60599758013, 5729.140628905698], "value": 5462.849991775456, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2034863109117, 598.2611474828587, 637.9776707815228, 670.8389986403265, 674.9021391898178, 34361.484577731324, 35169.47245791312, 37688.24623507528, 44732.77633611827, 46201.768991155084, 46536.76731616346, 46919.0, 46921.53078469214, 47080.764596177054, 47150.29274560876, 8721.520316382597, 8857.601407936627, 8858.114188581154, 8862.33532485063, 8874.423162494417, 8427.49435033897, 8596.097409771977, 8803.33974951878, 8906.643734250621, 10371.636992705256, 10500.474976251195, 10771.676849694522, 10781.299215551004, 10784.0, 10792.838107428395, 10571.73570660732, 10635.680929572125, 10642.680719578426, 10644.520996555173, 10645.57417703291, 10509.949005099505, 10510.78978420435, 10558.577656893793, 10571.62999295021, 10575.101116405114, 44232.557674423166, 44456.77771611154, 44501.777491112334, 44595.0, 44684.10631787346, 3683.650053244937, 3851.0372406898277, 3891.2217556488818, 3940.3695408734466, 4424.845130420452, 33176.83411582951, 33244.833775831205, 33634.49548256778, 34823.30353392918, 34927.301453971035, 4455.420795296591, 4458.152950939311, 4536.909261814778, 4542.114287713897, 4698.506656801021, 354153.0, 355909.0, 358593.0, 358597.0, 359354.0, 60343.39656603466, 60898.69550652307, 60920.69539652362, 60933.695331523944, 60944.0, 38960.805195974404, 38982.80508597439, 39658.60341396549, 65175.348246517875, 65460.67269663621, 18127.365542206222, 18597.535061623297, 18602.534936626693, 18657.720134197996, 18668.81331186698, 14575.635609109646, 14664.560063198121, 14671.0, 14673.266336683337, 14677.55967320982, 18580.349687760863, 18829.811701883078, 19781.901090494743, 20217.59564808725, 20555.58888822215, 7283.927160728431, 7285.198628150899, 7436.516626419266, 7477.0, 7611.619419029137, 1026.0662796854976, 1034.6689059501039, 1139.1171841822488, 1141.9143564232716, 1150.3500522204927, 33698.831505842805, 34199.316013679585, 34253.314933701186, 34263.31473370569, 34272.65727342694, 1173.8708742038539, 1189.970250743721, 1239.9938000309942, 1243.9875601244053, 1258.6035398849333, 17472.65054698899, 17675.85106968043, 17771.466855994084, 17959.582465130676, 17988.910055449902, 147054.0, 147163.0, 147201.0, 147905.2604736991, 148398.0, 61491.38508614946, 62202.68898655478, 62273.37726622676, 62294.377056229765, 62389.0, 1372.9244891531062, 1427.928603569838, 1442.3004842651305, 1443.3937746146644, 1446.4503488674236, 31264.0, 32683.0, 32801.34397312088, 33083.50374744429, 33218.50172247466, 53435.0, 53651.19523207077, 53754.73122634518, 53792.19311710249, 53799.73100134474, 435244.0, 437816.0, 437817.0, 438452.0, 438919.0, 27189.320266993484, 27225.591616125377, 31076.68923310738, 31469.685303146674, 31565.368692625558, 49041.26438103503, 49425.0, 49586.25620615621, 53209.733951329996, 54044.72977635244, 41258.0, 42425.78787106045, 43272.134557309306, 43813.56186438095, 43874.78062609667, 42246.155076898904, 43320.70037898868, 43372.34941475817, 43762.12475750403, 43953.0, 43542.346864797684, 44400.0, 44602.0, 44767.55232447634, 44784.77607611941, 36323.27353452969, 38684.41973370346, 39332.21335573215, 39486.21027579375, 39755.0, 28461.288467788472, 29443.263918402212, 29878.70121298759, 31185.688143118277, 31235.53146702756], "value": 20460.733467708495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.44454985769215, 414.81748030866436, 418.32022962685636, 425.9893502662433, 432.9004329004329, 19546.413607591778, 20019.699704504408, 20219.191232350706, 20639.896800516013, 20913.790862091413, 18453.44639660809, 18682.159302831373, 18711.438656840317, 18846.623067538676, 20259.797402025975, 5710.257666503359, 5912.497437717778, 5942.465178133967, 5944.613600115978, 5951.464368206861, 4190.120074784299, 5115.360579927509, 5770.134479828039, 5848.795292164775, 5849.151872978416, 6483.481321494292, 6606.075149479053, 6607.801765947005, 6609.834754131137, 6612.0, 6402.519811014169, 6543.443807276387, 6547.836304092388, 6548.148740663731, 6588.50586206034, 5699.943000569982, 5802.158686990405, 5812.534997200214, 5821.214136091616, 5871.6183448075735, 24066.398340041465, 24400.755992440027, 24509.509809803705, 24514.632280515627, 24832.255032349058, 2385.7852793248517, 2516.484120755241, 2572.974270257292, 2752.9538775265273, 2757.54500507416, 15080.622984425367, 15080.924595376953, 15204.16377099259, 15244.466443674419, 15694.52916412498, 1905.1902941249914, 1909.3412772593433, 1912.7895931447529, 1939.4763413878316, 2025.402506260642, 84537.0, 86202.13797862067, 86451.99999999937, 87353.56323218407, 89684.0, 10681.771596266528, 10822.783544329226, 10911.399873007062, 11011.449427528752, 11332.546698132148, 15487.148206848506, 15726.842731572538, 15803.841961580467, 15836.129012904401, 15862.841371586137, 8771.473711577326, 8831.470111793184, 8896.5996530155, 8906.198442140238, 9001.054889236666, 8802.471851688792, 8802.691905783267, 8830.381873268809, 9011.684591039413, 9016.143466370684, 6856.348646878539, 6882.621455819878, 6920.723171073201, 6947.548409353376, 6975.4070903972715, 1789.783078679545, 1873.8500919926646, 1992.8405727541763, 2000.8599398042288, 2029.1376165129761, 1040.8107367844336, 1059.862217911682, 1099.115212254143, 1100.2463312630873, 1112.1158678850172, 20249.29127480531, 20370.388888333375, 20720.44657511016, 20759.0, 20820.895895520425, 1057.0644979193316, 1072.5334479501441, 1094.655183617158, 1111.3831823338126, 1171.1041053594008, 11034.393108378956, 11733.08285702872, 11835.11236657237, 11901.285922844658, 11943.16397852142, 426769.0, 437245.0, 445821.0, 450256.0, 453906.0, 79360.6031969848, 80001.59999200083, 80355.59822200969, 81091.0, 84874.0, 1042.6298663974333, 1045.5347370420243, 1047.3087762077146, 1048.9318194317345, 1052.2529004406804, 17499.475015749547, 17953.640927181645, 18775.34286299973, 18785.154668040243, 18825.717614236073, 39670.80164599159, 40052.39921401123, 40808.79595602003, 41200.1759964805, 41217.793911030254, 53467.73266133644, 55113.72443137759, 55691.0, 56050.43949560615, 57157.714211428676, 6798.966005169942, 7673.386129109769, 8109.959450202711, 8515.872261915953, 8635.438696484709, 11736.70658233551, 13239.735205296032, 13282.203067815963, 13719.245441500812, 13854.376553054935, 11300.886991129983, 11737.178397512092, 11824.1131915105, 11954.76090478203, 11970.341631210367, 10389.324693894872, 10564.841527376942, 10956.233063685784, 11650.48543689315, 11716.882831171579, 10763.784724305313, 11184.433501465419, 11224.494897729459, 11359.716007099889, 11374.260673056226, 8159.224873636995, 8295.0, 8360.289375402916, 8368.581570921308, 8413.621387037476, 9850.802983940137, 9968.800623987625, 10288.537015834156, 10322.845157322796, 10370.948145259226], "value": 9586.807039059144, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.5578187089197, 1461.254760072363, 1516.1130738517968, 1638.418361481674, 1846.4829847642657, 7858.921410785898, 8253.0, 8324.292435143012, 8605.139486051392, 8605.56972151393, 8495.192956669121, 8550.95724521378, 8564.400491965565, 8566.614502347395, 8568.828623427544, 2404.6152615581555, 2431.720352159498, 2432.343267317823, 2434.6348047792885, 2435.671184390111, 2402.759724027592, 2464.0636558107894, 2475.418276704973, 2476.6037434010564, 2476.950460990779, 2399.904003839853, 2402.60357041088, 2420.854748715074, 2439.4145405102827, 2440.1337525178574, 2350.9294721158394, 2370.5495955768433, 2381.166591692911, 2394.0543485323287, 2396.305071529263, 2384.4396566806786, 2394.7246066702205, 2414.3119211024773, 2414.915477958263, 2418.9516209675708, 8825.779355516099, 8995.865062024075, 8996.730098097067, 9004.324675649352, 9008.549572521348, 5394.433584473652, 5562.276904002494, 5571.387147413781, 5644.758153206288, 5658.490735833753, 3347.071312601474, 3440.8107554084513, 3445.2937147884622, 3497.930041399183, 3512.4731290306404, 1141.3988865130527, 1142.7885841119419, 1166.5158959032076, 1196.3001644038247, 1210.0622017936082, 12426.751464970741, 12459.750804983849, 12470.75058498825, 12518.874811251862, 12568.371581420892, 4414.27164517851, 4705.835295764632, 4737.692050016738, 4738.123447162286, 4761.666683332202, 9774.51127443625, 9774.951125244328, 9782.461964591874, 9790.51047447639, 9814.312998090209, 5444.3194600674915, 5451.2640793493165, 5455.18172274162, 5456.099743542351, 5466.945330546723, 4249.553796851286, 4303.978480107642, 4515.277555591089, 5092.898142037138, 5114.744262786846, 3855.6722678572637, 3906.2968665639887, 3975.6421922027157, 4001.679865610744, 4004.1591265833918, 1226.8650448450662, 1247.6880779805049, 1253.4986005597834, 1260.4958016793173, 1261.1802328486374, 998.9400635961865, 1019.4453458475883, 1026.4252018869456, 1036.0778906772978, 1041.422010784007, 5861.618994765412, 6021.277446706424, 6176.227971503562, 6252.530655296002, 6417.197850268716, 494.2141994229193, 502.1488576862184, 512.3390825834706, 515.6361424033411, 517.0383087457326, 4202.873913782591, 4314.460692413449, 4322.222000040023, 4342.522322544518, 4376.606105450461, 10188.490575471345, 10494.632687855888, 10529.157667386591, 10537.63118290856, 10637.042666160083, 10405.0, 10420.11429028541, 10442.477876106317, 10453.425061621683, 10454.790904181873, 8023.117457079717, 8039.35685145187, 8141.982252218472, 8146.959265203636, 8147.67409303633, 5883.646981181143, 5884.558658100574, 5923.4076592340425, 5958.136070269873, 6024.307204671343, 9593.664221752484, 9637.903620963982, 9647.662331818352, 9668.0, 9715.805683886425, 9083.636654533744, 9416.246700264099, 10169.03394177552, 10451.21615878797, 10463.476826158814, 6960.338767817049, 7094.219635840157, 7102.680379382837, 7454.589997550187, 7538.09542854861, 8231.176882311722, 8276.544790036605, 8311.542865142475, 8347.332213423033, 8365.539895305817, 7391.519551229153, 7579.810504737426, 7664.961675191811, 7748.108967468813, 7884.645190966306, 7133.785986420416, 7224.2053374129855, 7366.742164024234, 7468.141163766237, 7542.622868856645, 7286.817829554091, 7447.180810110992, 7495.775126746206, 7502.587357695161, 7524.736634217776, 5297.8145764898045, 5409.486098820606, 5421.322334708161, 5570.3315602128005, 5593.384727680033, 5339.3058902342445, 5366.463353664602, 5381.165919282517, 5603.35561410443, 5632.774689012557], "value": 4594.9205009914285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.0450228105602, 347.5967877262376, 349.040139616056, 349.60145434205003, 351.08717334929185, 5387.892242155154, 5389.299391079159, 5396.1905714142895, 5412.134058550632, 5420.647657902244, 5100.209467532529, 5153.30430391897, 5245.973770131144, 5293.52358287754, 5338.078291814943, 4174.394712766647, 4200.96253317141, 4225.915481690365, 4228.302330115543, 4228.386883901832, 4164.604362585565, 4228.830846766125, 4233.661307095425, 4234.470691163605, 4243.681723870706, 3915.451836742858, 3925.607439256066, 4158.4594002779595, 4182.435371224876, 4223.767692776896, 4139.937900931488, 4147.3778933159965, 4168.145530166309, 4171.811033855367, 4194.454720886296, 3722.088088418328, 3730.5336832895887, 3737.458068580068, 3743.1016556026357, 3750.2124553843723, 5099.33708617881, 5118.513741194581, 5148.819791307324, 5260.210968354778, 5274.841754747364, 4701.0, 4712.387389639359, 4729.858104256878, 4732.83435079774, 4737.881552961169, 5476.0, 5490.69801160936, 5518.779248830042, 5520.861978450531, 5522.22688823565, 3927.3912543555793, 4084.877453676365, 4093.385992101179, 4119.691023173274, 4148.91702165958, 5646.830595082154, 5654.349749778787, 5677.744501497401, 5690.5447564194765, 5693.629914055615, 4118.361653943643, 4155.688323375698, 4157.0, 4164.271252530795, 4177.8328866845595, 3957.52509698838, 4118.238125946709, 4268.271350103213, 4269.701120921568, 4273.1240095780295, 4687.671862969628, 4698.342232087511, 4702.811887524529, 4720.645951553579, 4746.572808447257, 5511.724413779295, 5522.0, 5526.171074338801, 5598.552115830724, 5602.915956260659, 1353.7698591239514, 1384.494659449314, 1395.771720885614, 1398.1331574423923, 1406.585057408067, 922.3220932614523, 922.7554698005034, 940.2478017585904, 941.2987324443196, 953.9570719317647, 5270.841874743764, 5280.683159010472, 5305.708186049805, 5333.733313334318, 5391.110466772939, 5438.021156191923, 5452.345718513804, 5496.31296087989, 5516.531094856902, 5521.365043020024, 5194.714290714047, 5267.604929630293, 5537.556995440355, 5544.86137846549, 5584.21820945068, 2913.490139225627, 2924.4297362014204, 2926.9268268293035, 2944.36696110333, 2960.2155428811384, 5670.319561652628, 5761.769529218785, 5812.936407575335, 5871.500922421642, 5893.5560787606455, 5583.469570390806, 5585.888282234332, 5616.623927137795, 5628.690422026746, 5629.493345598916, 5811.331696854916, 5811.622244554091, 5817.185594016925, 5819.883602328015, 5878.941210587925, 5214.843554693365, 5441.238226648194, 5458.2904222450825, 5486.588505862156, 5493.807716729895, 5448.482394172547, 5448.991936491761, 5454.945450545444, 5489.917651235314, 5497.36780270274, 5592.3715853548765, 5867.9413205867395, 5875.559333050124, 5893.9371220072635, 5921.111833225051, 3970.974802850509, 4004.9386912468804, 4020.3567429211184, 4023.4970628671417, 4028.637422631977, 5519.172124181245, 5541.473560011793, 5551.361593416808, 5586.38549759518, 5635.5203710367305, 5276.762545685377, 5401.154422566198, 5454.972725136349, 5509.586780991362, 5533.6403133796175, 5334.866628334323, 5361.0, 5370.677759334452, 5385.8114965976, 5389.757460914347, 5297.417284098823, 5303.568036630166, 5335.253064570886, 5338.024930775638, 5432.538234250133, 5471.616986811045, 5566.304211973504, 5573.27547418833, 5580.023495888285, 5583.581231407742, 5444.754986025559, 5448.809291674773, 5453.15476101205, 5454.863628409322, 5502.779888804403], "value": 4220.863484998723, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.5133166105354, 795.5028107432854, 798.4690181029615, 839.8194388206537, 888.1340692824493, 14394.712105757892, 15097.698046039086, 15986.12076335801, 16032.59918502038, 16039.03765774053, 14163.504277350296, 14259.001869869113, 14539.200343981103, 14540.418383264656, 14552.708945821078, 839.1566475691936, 847.1232274595794, 847.8050048488851, 848.4442690038035, 849.5921957460423, 727.4725823777771, 749.5352881213655, 841.8148007438353, 870.2298465857698, 875.689130358723, 918.3525614441802, 920.3281604428771, 920.4063379120497, 920.5765347939956, 921.1985572551856, 906.5150144672568, 917.7797328641111, 917.9908200917972, 918.8851393575803, 919.5172534419416, 558.8463172627519, 572.2246356187347, 633.9936600634027, 644.1207751419325, 648.4261428635645, 14892.404303827941, 14938.103713777207, 14975.400983960628, 15033.924830375887, 15050.172240526766, 13672.794908076386, 14025.43898244069, 14190.43238270468, 14250.2162381069, 14311.069780464237, 12778.872211277954, 12810.42353094113, 12852.293123878182, 12958.48166073356, 13073.673158171026, 4205.285101532747, 4252.659787217015, 4281.529031806499, 4313.762743049131, 4358.4769827620885, 57849.42150578524, 59723.402765972656, 59840.700796496174, 61684.0, 61695.0, 11604.361760103275, 11693.415329233505, 11839.467223974942, 11911.166218364804, 12119.575814846614, 20682.68975965362, 20844.06201720926, 20855.0, 20886.373408797455, 21038.158473661188, 7617.695292188361, 7654.387648988068, 7778.92221077782, 7792.961035194788, 8360.45657032291, 4718.598919091847, 4725.976370118127, 4741.857744267678, 4823.807047718122, 4863.367762190893, 3299.769016168845, 3384.0, 3384.2047118927035, 3392.2028323343993, 3402.166469215058, 612.1766224428137, 629.6568370238231, 634.0267689097213, 635.3963734452196, 635.4503354598331, 540.2139886465184, 586.7711592478852, 624.1979056911937, 650.4146268358515, 675.5743881354715, 7735.131552060041, 8089.393295502743, 8310.792230194173, 8345.582720863933, 8850.159234872677, 572.5362456410321, 580.2630659062967, 585.2771826793906, 683.5112894280513, 702.3854127638316, 4477.552244775497, 4505.774711264424, 4598.218302888517, 4689.6248300136585, 4714.198586240347, 88283.0, 94456.0, 97035.0296497026, 97485.0, 100172.4991375053, 55538.72230638821, 65873.34126658768, 73124.0, 85152.0, 86780.0, 43075.35386969198, 43184.352234716505, 46263.768681156376, 63289.68355158195, 69097.65451172712, 8432.367572432215, 8831.470111793313, 8871.778205544913, 8986.910130898606, 9172.770680733034, 35006.82496587501, 36423.45364819583, 42211.0, 43986.34020489759, 47591.0, 55943.0, 56713.716431417575, 56790.0, 57505.13742293953, 58279.4172058274, 12668.303243321338, 12831.230126192459, 13030.087893847718, 13323.467061317438, 13613.387397566936, 13749.175049497062, 13953.0, 14412.495562655256, 14420.783688244894, 14454.205018724071, 13485.865141348853, 13652.0, 13802.17186968785, 14096.929515352358, 14572.781408278672, 12628.494860205488, 12650.0, 13123.737525249251, 13324.933375333061, 13552.796708049584, 12321.322327271728, 12630.684232894251, 12656.17734847232, 13016.934915325362, 13333.53332633392, 9716.611335546782, 9759.316847820868, 9762.121409073217, 9784.9021509784, 9976.50117494137, 9795.706128816148, 10432.530536125741, 10534.157267418741, 10572.84140737874, 10693.358398496115], "value": 7102.084345366971, "unit": "score"}], "name": "dromaeo_css", "value": 7269.774748382052, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 113.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 118.0, 159.0, 122.0, 118.0, 120.0, 118.0, 148.0, 123.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 160.0, 162.0, 162.0, 161.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 109.0, 76.0, 76.0, 75.0, 76.0, 96.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 126.0, 81.0, 82.0, 82.0, 98.0, 83.0, 83.0, 107.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 49.0, 49.0, 49.0, 50.0, 51.0, 50.0, 59.0, 52.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0, 58.0, 57.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 74.0, 75.0, 75.0, 74.0, 75.0, 77.0, 75.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 123.0, 121.0, 121.0, 120.0, 120.0, 119.0, 170.0, 127.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 155.0, 152.0, 151.0, 152.0, 158.0, 155.0, 152.0, 152.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 61.0, 60.0, 63.0, 60.0, 62.0, 61.0, 63.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1446.7, "alertThreshold": 2.0}]} 03:02:34 INFO - Return code: 0 03:02:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:02:34 INFO - # TBPL SUCCESS # 03:02:34 INFO - Running post-action listener: _resource_record_post_action 03:02:34 INFO - [mozharness: 2016-12-26 11:02:34.405555Z] Finished run-tests step (success) 03:02:34 INFO - Running post-run listener: _resource_record_post_run 03:02:34 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 270336; Write bytes: 358432768; Read time: 28; Write time: 239944 03:02:34 INFO - TinderboxPrint: CPU usage
13.0% 03:02:34 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 28 03:02:34 INFO - TinderboxPrint: I/O write bytes / time
358,432,768 / 239,944 03:02:34 INFO - TinderboxPrint: CPU idle
8,269.3 (87.0%) 03:02:34 INFO - TinderboxPrint: CPU user
1,194.7 (12.6%) 03:02:34 INFO - TinderboxPrint: Swap in / out
0 / 0 03:02:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108007424; Read time: 0; Write time: 88672 03:02:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249942016; Read time: 20; Write time: 151236 03:02:35 INFO - Running post-run listener: _upload_blobber_files 03:02:35 INFO - Blob upload gear active. 03:02:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:02:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:02:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:02:35 INFO - (blobuploader) - INFO - Open directory for files ... 03:02:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:02:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:02:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:36 INFO - (blobuploader) - INFO - Done attempting. 03:02:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:02:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:02:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:39 INFO - (blobuploader) - INFO - Done attempting. 03:02:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:02:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:02:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:40 INFO - (blobuploader) - INFO - Done attempting. 03:02:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:02:40 INFO - Return code: 0 03:02:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:02:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:02:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7ea474accfd61922af68c9365caa999409060a25a1cff6318f49e10cdfc6f21e4667bbfa8e88e896c3dd0ba2f265c4aec7144224fb09c027f448e32610c4a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/819836afdd63b451e86ea12455d2a4cb66ed2e38425d7ba7cc4ac56a0a3d38fa784ad33dfbd135caee09525cc33df4e3ec0625e342e398b68e96e4b6ee02fded", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a06700716d2fd4f10b89f5a3293cf9126e394e5bb1f11907c0e8abc1d55f1517a56343df5ca94bb80f8a0cb265235204d96c963089d06bdb0fa7a615a3eb5a6"} 03:02:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:02:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:02:40 INFO - Contents: 03:02:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7ea474accfd61922af68c9365caa999409060a25a1cff6318f49e10cdfc6f21e4667bbfa8e88e896c3dd0ba2f265c4aec7144224fb09c027f448e32610c4a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/819836afdd63b451e86ea12455d2a4cb66ed2e38425d7ba7cc4ac56a0a3d38fa784ad33dfbd135caee09525cc33df4e3ec0625e342e398b68e96e4b6ee02fded", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a06700716d2fd4f10b89f5a3293cf9126e394e5bb1f11907c0e8abc1d55f1517a56343df5ca94bb80f8a0cb265235204d96c963089d06bdb0fa7a615a3eb5a6"} 03:02:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:02:40 INFO - Copying logs to upload dir... 03:02:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:02:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.196187 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-26 03:02:39.821656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-26 03:02:39.827482) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7ea474accfd61922af68c9365caa999409060a25a1cff6318f49e10cdfc6f21e4667bbfa8e88e896c3dd0ba2f265c4aec7144224fb09c027f448e32610c4a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/819836afdd63b451e86ea12455d2a4cb66ed2e38425d7ba7cc4ac56a0a3d38fa784ad33dfbd135caee09525cc33df4e3ec0625e342e398b68e96e4b6ee02fded", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a06700716d2fd4f10b89f5a3293cf9126e394e5bb1f11907c0e8abc1d55f1517a56343df5ca94bb80f8a0cb265235204d96c963089d06bdb0fa7a615a3eb5a6"} build_url:https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011826 build_url: 'https://queue.taskcluster.net/v1/task/Qe5QsACFRCCnKCJpNc9kXA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7ea474accfd61922af68c9365caa999409060a25a1cff6318f49e10cdfc6f21e4667bbfa8e88e896c3dd0ba2f265c4aec7144224fb09c027f448e32610c4a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/819836afdd63b451e86ea12455d2a4cb66ed2e38425d7ba7cc4ac56a0a3d38fa784ad33dfbd135caee09525cc33df4e3ec0625e342e398b68e96e4b6ee02fded", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a06700716d2fd4f10b89f5a3293cf9126e394e5bb1f11907c0e8abc1d55f1517a56343df5ca94bb80f8a0cb265235204d96c963089d06bdb0fa7a615a3eb5a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-26 03:02:39.857667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 03:02:39.858025) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1482737730.252390-1525702729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 03:02:39.945946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-26 03:02:39.947216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-26 03:02:39.947763) ========= ========= Total master_lag: 0.19 =========