builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1477969851.67 results: success (0) buildid: 20161031183650 builduid: 223e49526c73495887db2c83fea2444b revision: 62c5218b7325723c8d88d5c4cfe4fa241f905406 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:51.674357) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:51.674830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:51.675158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:51.691224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:51.691680) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 20:10:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-10-31 20:10:52 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123270 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:51.829535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:51.829851) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014322 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:51.881642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:51.882388) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 62c5218b7325723c8d88d5c4cfe4fa241f905406 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 62c5218b7325723c8d88d5c4cfe4fa241f905406 --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=e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 20:10:52,152 truncating revision to first 12 chars 2016-10-31 20:10:52,153 Setting DEBUG logging. 2016-10-31 20:10:52,153 attempt 1/10 2016-10-31 20:10:52,153 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/62c5218b7325?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 20:10:52,793 unpacking tar archive at: mozilla-central-62c5218b7325/testing/mozharness/ program finished with exit code 0 elapsedTime=0.955910 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:52.852920) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:52.853236) ========= script_repo_revision: 62c5218b7325723c8d88d5c4cfe4fa241f905406 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:52.853621) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:52.853881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 20:10:52.863845) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-31 20:10:52.864257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:10:53 INFO - MultiFileLogger online at 20161031 20:10:53 in /builds/slave/test 20:10:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:10:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:10:53 INFO - {'append_to_log': False, 20:10:53 INFO - 'base_work_dir': '/builds/slave/test', 20:10:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:10:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:10:53 INFO - 'branch': 'Firefox-Non-PGO', 20:10:53 INFO - 'buildbot_json_path': 'buildprops.json', 20:10:53 INFO - 'config_files': ('talos/linux_config.py',), 20:10:53 INFO - 'default_actions': ('clobber', 20:10:53 INFO - 'read-buildbot-config', 20:10:53 INFO - 'download-and-extract', 20:10:53 INFO - 'populate-webroot', 20:10:53 INFO - 'create-virtualenv', 20:10:53 INFO - 'install', 20:10:53 INFO - 'run-tests'), 20:10:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:10:53 INFO - 'download_minidump_stackwalk': True, 20:10:53 INFO - 'download_symbols': 'ondemand', 20:10:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:10:53 INFO - 'tooltool.py': '/tools/tooltool.py', 20:10:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:10:53 INFO - '/tools/misc-python/virtualenv.py')}, 20:10:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:10:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:10:53 INFO - 'installer_path': 'installer.exe', 20:10:53 INFO - 'log_level': 'info', 20:10:53 INFO - 'log_name': 'talos', 20:10:53 INFO - 'log_to_console': True, 20:10:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:10:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:10:53 INFO - 'opt_config_files': (), 20:10:53 INFO - 'pip_index': False, 20:10:53 INFO - 'sps_profile': False, 20:10:53 INFO - 'sps_profile_interval': 0, 20:10:53 INFO - 'suite': 'dromaeojs', 20:10:53 INFO - 'system_bits': '32', 20:10:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:10:53 INFO - 'title': 'talos-linux64-ix-006', 20:10:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:10:53 INFO - 'use_talos_json': True, 20:10:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:10:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:10:53 INFO - 'work_dir': 'build'} 20:10:53 INFO - [mozharness: 2016-11-01 03:10:53.237126Z] Running clobber step. 20:10:53 INFO - Running pre-action listener: _resource_record_pre_action 20:10:53 INFO - Running main action method: clobber 20:10:53 INFO - rmtree: /builds/slave/test/build 20:10:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:10:53 INFO - Running post-action listener: _resource_record_post_action 20:10:53 INFO - [mozharness: 2016-11-01 03:10:53.704516Z] Finished clobber step (success) 20:10:53 INFO - [mozharness: 2016-11-01 03:10:53.704616Z] Running read-buildbot-config step. 20:10:53 INFO - Running pre-action listener: _resource_record_pre_action 20:10:53 INFO - Running main action method: read_buildbot_config 20:10:53 INFO - Using buildbot properties: 20:10:53 INFO - { 20:10:53 INFO - "project": "", 20:10:53 INFO - "product": "firefox", 20:10:53 INFO - "script_repo_revision": "production", 20:10:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:10:53 INFO - "repository": "", 20:10:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:10:53 INFO - "buildid": "20161031183650", 20:10:53 INFO - "pgo_build": "False", 20:10:53 INFO - "basedir": "/builds/slave/test", 20:10:53 INFO - "buildnumber": 279, 20:10:53 INFO - "slavename": "talos-linux64-ix-006", 20:10:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:10:53 INFO - "platform": "ubuntu64_hw", 20:10:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:10:53 INFO - "branch": "mozilla-central", 20:10:53 INFO - "repo_path": "mozilla-central", 20:10:53 INFO - "revision": "62c5218b7325723c8d88d5c4cfe4fa241f905406", 20:10:53 INFO - "stage_platform": "linux64", 20:10:53 INFO - "builduid": "223e49526c73495887db2c83fea2444b", 20:10:53 INFO - "slavebuilddir": "test" 20:10:53 INFO - } 20:10:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:10:53 INFO - Running post-action listener: _resource_record_post_action 20:10:53 INFO - [mozharness: 2016-11-01 03:10:53.707051Z] Finished read-buildbot-config step (success) 20:10:53 INFO - [mozharness: 2016-11-01 03:10:53.707139Z] Running download-and-extract step. 20:10:53 INFO - Running pre-action listener: _resource_record_pre_action 20:10:53 INFO - Running main action method: download_and_extract 20:10:53 INFO - mkdir: /builds/slave/test/build/tests 20:10:53 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')]} 20:10:53 INFO - trying https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:10:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:10:54 INFO - Downloaded 1361 bytes. 20:10:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:10:54 INFO - Using the following test package requirements: 20:10:54 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:10:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:10:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:10:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:54 INFO - u'jsshell-linux-x86_64.zip'], 20:10:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:10:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:10:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:10:54 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:10:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:10:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:10:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:10:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:10:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:10:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:10:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:10:54 INFO - Http code: 200 20:10:54 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 20:10:54 INFO - x-amz-cf-id: oOhZ5bcjTHLoBvqC4OYrmclp03AiL0JhMoH2j8mazRAK3hJc7xL-ZQ== 20:10:54 INFO - x-amz-version-id: DQfBDR9Xcq0AfgEmX9Fm2w7AQDBTWfbV 20:10:55 INFO - Expected file size: 20451679 20:10:55 INFO - Obtained file size: 20451679 20:10:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:10:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:10:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:10:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:10:59 INFO - Http code: 200 20:10:59 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 20:10:59 INFO - x-amz-cf-id: DVVg8VgJPbk6eznMd-LfoAWVOum_W9lDcsbqGa6ToE2jLss2-FxGOw== 20:10:59 INFO - x-amz-version-id: DQfBDR9Xcq0AfgEmX9Fm2w7AQDBTWfbV 20:11:00 INFO - Expected file size: 20451679 20:11:00 INFO - Obtained file size: 20451679 20:11:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:11:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:11:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:11:04 INFO - Http code: 200 20:11:04 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 20:11:04 INFO - x-amz-cf-id: STGQ9I3UgaxEqffr-0YPkgaUfJw5IlkA46GttnTDCahQ-Eaq20g-uQ== 20:11:04 INFO - x-amz-version-id: XE2S_E9v92N4Sj5l5GzQyC2bQCATapdY 20:11:05 INFO - Expected file size: 14409038 20:11:05 INFO - Obtained file size: 14409038 20:11: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')]} 20:11:05 INFO - trying https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:11:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:11:06 INFO - Downloaded 55778422 bytes. 20:11:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:11:06 INFO - mkdir: /builds/slave/test/properties 20:11:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:11:06 INFO - Writing to file /builds/slave/test/properties/build_url 20:11:06 INFO - Contents: 20:11:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:11:07 INFO - Running post-action listener: _resource_record_post_action 20:11:07 INFO - Running post-action listener: set_extra_try_arguments 20:11:07 INFO - [mozharness: 2016-11-01 03:11:07.220894Z] Finished download-and-extract step (success) 20:11:07 INFO - [mozharness: 2016-11-01 03:11:07.221121Z] Running populate-webroot step. 20:11:07 INFO - Running pre-action listener: _resource_record_pre_action 20:11:07 INFO - Running main action method: populate_webroot 20:11:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:11:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:11:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:11:07 INFO - '--tppagecycles', 20:11:07 INFO - '7'], 20:11:07 INFO - 'tests': ['tsvgm']}}, 20:11:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:11:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:11:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:11:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:11:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['damp', 'tps']}, 20:11:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'tests': ['damp', 'tps']}, 20:11:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['dromaeo_dom']}, 20:11:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:11:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['basic_compositor_video']}, 20:11:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:11:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'other-e10s': {'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['a11yr', 20:11:07 INFO - 'ts_paint', 20:11:07 INFO - 'tpaint', 20:11:07 INFO - 'sessionrestore', 20:11:07 INFO - 'sessionrestore_no_auto_restore', 20:11:07 INFO - 'tabpaint']}, 20:11:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['tsvgx', 20:11:07 INFO - 'tsvgr_opacity', 20:11:07 INFO - 'tart', 20:11:07 INFO - 'tscrollx', 20:11:07 INFO - 'cart']}, 20:11:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:11:07 INFO - 'tsvgr_opacity', 20:11:07 INFO - 'tart', 20:11:07 INFO - 'tscrollx', 20:11:07 INFO - 'cart']}, 20:11:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'talos_options': ['--disable-e10s'], 20:11:07 INFO - 'tests': ['tp5o']}, 20:11:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'tests': ['tp5o']}, 20:11:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'talos_options': ['--disable-e10s', 20:11:07 INFO - '--xperf_path', 20:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:07 INFO - 'tests': ['tp5n']}, 20:11:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:07 INFO - 'talos_options': ['--xperf_path', 20:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:07 INFO - 'tests': ['tp5n']}}, 20:11:07 INFO - 'talos.zip': {'path': '', 20:11:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:11:07 INFO - Running post-action listener: _resource_record_post_action 20:11:07 INFO - [mozharness: 2016-11-01 03:11:07.237183Z] Finished populate-webroot step (success) 20:11:07 INFO - [mozharness: 2016-11-01 03:11:07.237270Z] Running create-virtualenv step. 20:11:07 INFO - Running pre-action listener: _resource_record_pre_action 20:11:07 INFO - Running main action method: create_virtualenv 20:11:07 INFO - Creating virtualenv /builds/slave/test/build/venv 20:11:07 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 20:11:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:11:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:11:07 INFO - Using real prefix '/usr' 20:11:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:11:07 INFO - Installing distribute.............................................................................................................................................................................................done. 20:11:09 INFO - Installing pip.................done. 20:11:09 INFO - Return code: 0 20:11:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:11:10 INFO - Reading from file tmpfile_stdout 20:11:10 INFO - Output received: 20:11:10 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) 20:11:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:11:10 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')]} 20:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:10 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')]} 20:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:10 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 0x7ff23d506f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', '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 20:11:10 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 20:11:10 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 20:11:10 INFO - Using env: {'DISPLAY': ':0', 20:11:10 INFO - 'HOME': '/home/cltbld', 20:11:10 INFO - 'LANG': 'en_US.UTF-8', 20:11:10 INFO - 'LANGUAGE': 'en_US:en', 20:11:10 INFO - 'LOGNAME': 'cltbld', 20:11:10 INFO - 'MAIL': '/var/mail/cltbld', 20:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:10 INFO - 'MOZ_NO_REMOTE': '1', 20:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:10 INFO - 'NO_EM_RESTART': '1', 20:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:10 INFO - 'PWD': '/builds/slave/test', 20:11:10 INFO - 'SHELL': '/bin/bash', 20:11:10 INFO - 'SHLVL': '1', 20:11:10 INFO - 'TERM': 'linux', 20:11:10 INFO - 'TMOUT': '86400', 20:11:10 INFO - 'USER': 'cltbld', 20:11:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:10 INFO - '_': '/tools/buildbot/bin/python'} 20:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:10 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 20:11:10 INFO - Cleaning up... 20:11:10 INFO - Return code: 0 20:11:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:11:10 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')]} 20:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:10 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')]} 20:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:10 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 0x7ff23d506f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', '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 20:11:10 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 20:11:10 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 20:11:10 INFO - Using env: {'DISPLAY': ':0', 20:11:10 INFO - 'HOME': '/home/cltbld', 20:11:10 INFO - 'LANG': 'en_US.UTF-8', 20:11:10 INFO - 'LANGUAGE': 'en_US:en', 20:11:10 INFO - 'LOGNAME': 'cltbld', 20:11:10 INFO - 'MAIL': '/var/mail/cltbld', 20:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:10 INFO - 'MOZ_NO_REMOTE': '1', 20:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:10 INFO - 'NO_EM_RESTART': '1', 20:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:10 INFO - 'PWD': '/builds/slave/test', 20:11:10 INFO - 'SHELL': '/bin/bash', 20:11:10 INFO - 'SHLVL': '1', 20:11:10 INFO - 'TERM': 'linux', 20:11:10 INFO - 'TMOUT': '86400', 20:11:10 INFO - 'USER': 'cltbld', 20:11:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:10 INFO - '_': '/tools/buildbot/bin/python'} 20:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:10 INFO - Downloading/unpacking psutil>=3.1.1 20:11:10 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 20:11:10 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 20:11:10 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 20:11:10 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 20:11:10 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 20:11:10 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 20:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:12 INFO - Installing collected packages: psutil 20:11:12 INFO - Running setup.py install for psutil 20:11:12 INFO - building 'psutil._psutil_linux' extension 20:11:12 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 20:11:12 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 20:11:12 INFO - building 'psutil._psutil_posix' extension 20:11:12 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 20:11:12 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 20:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:13 INFO - Successfully installed psutil 20:11:13 INFO - Cleaning up... 20:11:13 INFO - Return code: 0 20:11:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:11:13 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')]} 20:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:13 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')]} 20:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:13 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 0x7ff23d506f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', '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 20:11:13 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 20:11:13 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 20:11:13 INFO - Using env: {'DISPLAY': ':0', 20:11:13 INFO - 'HOME': '/home/cltbld', 20:11:13 INFO - 'LANG': 'en_US.UTF-8', 20:11:13 INFO - 'LANGUAGE': 'en_US:en', 20:11:13 INFO - 'LOGNAME': 'cltbld', 20:11:13 INFO - 'MAIL': '/var/mail/cltbld', 20:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:13 INFO - 'MOZ_NO_REMOTE': '1', 20:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:13 INFO - 'NO_EM_RESTART': '1', 20:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:13 INFO - 'PWD': '/builds/slave/test', 20:11:13 INFO - 'SHELL': '/bin/bash', 20:11:13 INFO - 'SHLVL': '1', 20:11:13 INFO - 'TERM': 'linux', 20:11:13 INFO - 'TMOUT': '86400', 20:11:13 INFO - 'USER': 'cltbld', 20:11:13 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:13 INFO - '_': '/tools/buildbot/bin/python'} 20:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:11:13 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 20:11:13 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 20:11:13 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 20:11:13 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 20:11:13 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 20:11:13 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 20:11:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:11:15 INFO - Installing collected packages: mozsystemmonitor 20:11:15 INFO - Running setup.py install for mozsystemmonitor 20:11:15 INFO - Successfully installed mozsystemmonitor 20:11:15 INFO - Cleaning up... 20:11:15 INFO - Return code: 0 20:11:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:11:15 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')]} 20:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:15 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')]} 20:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:15 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 0x7ff23d506f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', '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 20:11:15 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 20:11:15 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 20:11:15 INFO - Using env: {'DISPLAY': ':0', 20:11:15 INFO - 'HOME': '/home/cltbld', 20:11:15 INFO - 'LANG': 'en_US.UTF-8', 20:11:15 INFO - 'LANGUAGE': 'en_US:en', 20:11:15 INFO - 'LOGNAME': 'cltbld', 20:11:15 INFO - 'MAIL': '/var/mail/cltbld', 20:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:15 INFO - 'MOZ_NO_REMOTE': '1', 20:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:15 INFO - 'NO_EM_RESTART': '1', 20:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:15 INFO - 'PWD': '/builds/slave/test', 20:11:15 INFO - 'SHELL': '/bin/bash', 20:11:15 INFO - 'SHLVL': '1', 20:11:15 INFO - 'TERM': 'linux', 20:11:15 INFO - 'TMOUT': '86400', 20:11:15 INFO - 'USER': 'cltbld', 20:11:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:15 INFO - '_': '/tools/buildbot/bin/python'} 20:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:15 INFO - Downloading/unpacking jsonschema==2.5.1 20:11:15 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 20:11:15 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 20:11:15 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 20:11:15 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 20:11:15 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 20:11:15 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 20:11:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:11:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:11:17 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 20:11:17 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 20:11:17 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 20:11:17 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 20:11:17 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 20:11:17 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 20:11:17 INFO - Downloading functools32-3.2.3-2.tar.gz 20:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:11:17 INFO - warning: no files found matching '*.txt' 20:11:17 INFO - no previously-included directories found matching 'build' 20:11:17 INFO - no previously-included directories found matching 'dist' 20:11:17 INFO - no previously-included directories found matching '.git*' 20:11:17 INFO - Installing collected packages: jsonschema, functools32 20:11:17 INFO - Running setup.py install for functools32 20:11:17 INFO - warning: no files found matching '*.txt' 20:11:17 INFO - no previously-included directories found matching 'build' 20:11:17 INFO - no previously-included directories found matching 'dist' 20:11:17 INFO - no previously-included directories found matching '.git*' 20:11:17 INFO - Successfully installed jsonschema functools32 20:11:17 INFO - Cleaning up... 20:11:18 INFO - Return code: 0 20:11:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:11:18 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')]} 20:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:18 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')]} 20:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:18 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 0x7ff23d506f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', '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 20:11:18 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 20:11:18 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 20:11:18 INFO - Using env: {'DISPLAY': ':0', 20:11:18 INFO - 'HOME': '/home/cltbld', 20:11:18 INFO - 'LANG': 'en_US.UTF-8', 20:11:18 INFO - 'LANGUAGE': 'en_US:en', 20:11:18 INFO - 'LOGNAME': 'cltbld', 20:11:18 INFO - 'MAIL': '/var/mail/cltbld', 20:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:18 INFO - 'MOZ_NO_REMOTE': '1', 20:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:18 INFO - 'NO_EM_RESTART': '1', 20:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:18 INFO - 'PWD': '/builds/slave/test', 20:11:18 INFO - 'SHELL': '/bin/bash', 20:11:18 INFO - 'SHLVL': '1', 20:11:18 INFO - 'TERM': 'linux', 20:11:18 INFO - 'TMOUT': '86400', 20:11:18 INFO - 'USER': 'cltbld', 20:11:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:18 INFO - '_': '/tools/buildbot/bin/python'} 20:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:11:18 INFO - Cleaning up... 20:11:18 INFO - Return code: 0 20:11:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:11:18 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')]} 20:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:18 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')]} 20:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:18 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 0x7ff23d506f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', '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 20:11:18 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 20:11:18 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 20:11:18 INFO - Using env: {'DISPLAY': ':0', 20:11:18 INFO - 'HOME': '/home/cltbld', 20:11:18 INFO - 'LANG': 'en_US.UTF-8', 20:11:18 INFO - 'LANGUAGE': 'en_US:en', 20:11:18 INFO - 'LOGNAME': 'cltbld', 20:11:18 INFO - 'MAIL': '/var/mail/cltbld', 20:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:18 INFO - 'MOZ_NO_REMOTE': '1', 20:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:18 INFO - 'NO_EM_RESTART': '1', 20:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:18 INFO - 'PWD': '/builds/slave/test', 20:11:18 INFO - 'SHELL': '/bin/bash', 20:11:18 INFO - 'SHLVL': '1', 20:11:18 INFO - 'TERM': 'linux', 20:11:18 INFO - 'TMOUT': '86400', 20:11:18 INFO - 'USER': 'cltbld', 20:11:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:18 INFO - '_': '/tools/buildbot/bin/python'} 20:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:18 INFO - Downloading/unpacking blobuploader==1.2.4 20:11:18 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 20:11:18 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 20:11:18 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 20:11:18 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 20:11:18 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 20:11:18 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 20:11:20 INFO - Downloading blobuploader-1.2.4.tar.gz 20:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:11:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:11:20 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 20:11:20 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 20:11:20 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 20:11:20 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 20:11:20 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 20:11:20 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 20:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:11:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:11:20 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 20:11:20 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 20:11:20 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 20:11:20 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 20:11:20 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 20:11:20 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 20:11:21 INFO - Downloading docopt-0.6.1.tar.gz 20:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:11:21 INFO - Installing collected packages: blobuploader, requests, docopt 20:11:21 INFO - Running setup.py install for blobuploader 20:11:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:11:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:11:21 INFO - Running setup.py install for requests 20:11:21 INFO - Running setup.py install for docopt 20:11:21 INFO - Successfully installed blobuploader requests docopt 20:11:21 INFO - Cleaning up... 20:11:21 INFO - Return code: 0 20:11:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:21 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')]} 20:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:21 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')]} 20:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:21 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 0x7ff23d506f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', '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 20:11:21 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 20:11:21 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 20:11:21 INFO - Using env: {'DISPLAY': ':0', 20:11:21 INFO - 'HOME': '/home/cltbld', 20:11:21 INFO - 'LANG': 'en_US.UTF-8', 20:11:21 INFO - 'LANGUAGE': 'en_US:en', 20:11:21 INFO - 'LOGNAME': 'cltbld', 20:11:21 INFO - 'MAIL': '/var/mail/cltbld', 20:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:21 INFO - 'MOZ_NO_REMOTE': '1', 20:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:21 INFO - 'NO_EM_RESTART': '1', 20:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:21 INFO - 'PWD': '/builds/slave/test', 20:11:21 INFO - 'SHELL': '/bin/bash', 20:11:21 INFO - 'SHLVL': '1', 20:11:21 INFO - 'TERM': 'linux', 20:11:21 INFO - 'TMOUT': '86400', 20:11:21 INFO - 'USER': 'cltbld', 20:11:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:21 INFO - '_': '/tools/buildbot/bin/python'} 20:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:22 INFO - Running setup.py (path:/tmp/pip-b0exes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:22 INFO - Running setup.py (path:/tmp/pip-gueQnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:22 INFO - Running setup.py (path:/tmp/pip-Mqc1I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:22 INFO - Running setup.py (path:/tmp/pip-L_eGUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:22 INFO - Running setup.py (path:/tmp/pip-beSMlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:22 INFO - Running setup.py (path:/tmp/pip-dLTBpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:22 INFO - Running setup.py (path:/tmp/pip-ZMuRKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:22 INFO - Running setup.py (path:/tmp/pip-ME6O9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:22 INFO - Running setup.py (path:/tmp/pip-N2P3FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:22 INFO - Running setup.py (path:/tmp/pip-ZtJp7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:22 INFO - Running setup.py (path:/tmp/pip-5e09Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:22 INFO - Running setup.py (path:/tmp/pip-qMo0Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:22 INFO - Running setup.py (path:/tmp/pip-M3IVSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:22 INFO - Running setup.py (path:/tmp/pip-h9UtAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:23 INFO - Running setup.py (path:/tmp/pip-iv4mrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:23 INFO - Running setup.py (path:/tmp/pip-lAXq2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:23 INFO - Running setup.py (path:/tmp/pip-FLElUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:11:23 INFO - Running setup.py install for manifestparser 20:11:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:11:23 INFO - Running setup.py install for mozcrash 20:11:23 INFO - Running setup.py install for mozdebug 20:11:23 INFO - Running setup.py install for mozdevice 20:11:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:11:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:11:23 INFO - Running setup.py install for mozfile 20:11:23 INFO - Running setup.py install for mozhttpd 20:11:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:11:23 INFO - Running setup.py install for mozinfo 20:11:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:11:23 INFO - Running setup.py install for mozInstall 20:11:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Running setup.py install for mozleak 20:11:24 INFO - Running setup.py install for mozlog 20:11:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Running setup.py install for moznetwork 20:11:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Running setup.py install for mozprocess 20:11:24 INFO - Running setup.py install for mozprofile 20:11:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Running setup.py install for mozrunner 20:11:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:11:24 INFO - Running setup.py install for mozscreenshot 20:11:24 INFO - Running setup.py install for moztest 20:11:24 INFO - Running setup.py install for mozversion 20:11:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:11:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:11:25 INFO - Cleaning up... 20:11:25 INFO - Return code: 0 20:11:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:25 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')]} 20:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:25 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')]} 20:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:25 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 0x7ff23d506f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', '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 20:11:25 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 20:11:25 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 20:11:25 INFO - Using env: {'DISPLAY': ':0', 20:11:25 INFO - 'HOME': '/home/cltbld', 20:11:25 INFO - 'LANG': 'en_US.UTF-8', 20:11:25 INFO - 'LANGUAGE': 'en_US:en', 20:11:25 INFO - 'LOGNAME': 'cltbld', 20:11:25 INFO - 'MAIL': '/var/mail/cltbld', 20:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:25 INFO - 'MOZ_NO_REMOTE': '1', 20:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:25 INFO - 'NO_EM_RESTART': '1', 20:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:25 INFO - 'PWD': '/builds/slave/test', 20:11:25 INFO - 'SHELL': '/bin/bash', 20:11:25 INFO - 'SHLVL': '1', 20:11:25 INFO - 'TERM': 'linux', 20:11:25 INFO - 'TMOUT': '86400', 20:11:25 INFO - 'USER': 'cltbld', 20:11:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:25 INFO - '_': '/tools/buildbot/bin/python'} 20:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:25 INFO - Running setup.py (path:/tmp/pip-i6Tcrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:25 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)) 20:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:25 INFO - Running setup.py (path:/tmp/pip-Y_w8Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:25 INFO - Running setup.py (path:/tmp/pip-xWakJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:25 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)) 20:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:25 INFO - Running setup.py (path:/tmp/pip-aVzT2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:25 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)) 20:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:25 INFO - Running setup.py (path:/tmp/pip-2tCSsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:25 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)) 20:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:25 INFO - Running setup.py (path:/tmp/pip-GCRXZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:25 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)) 20:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:25 INFO - Running setup.py (path:/tmp/pip-kzGj2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:25 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)) 20:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:25 INFO - Running setup.py (path:/tmp/pip-GTVLQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:25 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)) 20:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:25 INFO - Running setup.py (path:/tmp/pip-q1j9ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:25 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)) 20:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:25 INFO - Running setup.py (path:/tmp/pip-Dh0rkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:26 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)) 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:26 INFO - Running setup.py (path:/tmp/pip-wQIWqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:26 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)) 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:26 INFO - Running setup.py (path:/tmp/pip-93GdId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:26 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)) 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:26 INFO - Running setup.py (path:/tmp/pip-wDdtmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:26 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)) 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:26 INFO - Running setup.py (path:/tmp/pip-R0T1OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:26 INFO - Running setup.py (path:/tmp/pip-Ymo9N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:26 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)) 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:26 INFO - Running setup.py (path:/tmp/pip-uvuT3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:26 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)) 20:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:26 INFO - Running setup.py (path:/tmp/pip-TAJcTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:26 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)) 20:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:11:26 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)) 20:11:26 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)) 20:11:26 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)) 20:11:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:28 INFO - Downloading blessings-1.6.tar.gz 20:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:11:28 INFO - Installing collected packages: blessings 20:11:28 INFO - Running setup.py install for blessings 20:11:28 INFO - Successfully installed blessings 20:11:28 INFO - Cleaning up... 20:11:28 INFO - Return code: 0 20:11:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:11:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:28 INFO - Reading from file tmpfile_stdout 20:11:28 INFO - Current package versions: 20:11:28 INFO - argparse == 1.2.1 20:11:28 INFO - blessings == 1.6 20:11:28 INFO - blobuploader == 1.2.4 20:11:28 INFO - docopt == 0.6.1 20:11:28 INFO - functools32 == 3.2.3-2 20:11:28 INFO - jsonschema == 2.5.1 20:11:28 INFO - manifestparser == 1.1 20:11:28 INFO - mozInstall == 1.12 20:11:28 INFO - mozcrash == 0.17 20:11:28 INFO - mozdebug == 0.1 20:11:28 INFO - mozdevice == 0.48 20:11:28 INFO - mozfile == 1.2 20:11:28 INFO - mozhttpd == 0.7 20:11:28 INFO - mozinfo == 0.9 20:11:28 INFO - mozleak == 0.1 20:11:28 INFO - mozlog == 3.4 20:11:28 INFO - moznetwork == 0.27 20:11:28 INFO - mozprocess == 0.23 20:11:28 INFO - mozprofile == 0.28 20:11:28 INFO - mozrunner == 6.12 20:11:28 INFO - mozscreenshot == 0.1 20:11:28 INFO - mozsystemmonitor == 0.3 20:11:28 INFO - moztest == 0.7 20:11:28 INFO - mozversion == 1.4 20:11:28 INFO - psutil == 3.1.1 20:11:28 INFO - requests == 1.2.3 20:11:28 INFO - wsgiref == 0.1.2 20:11:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11: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')]} 20:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11: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')]} 20:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:28 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 0x7ff23d506f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', '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 20:11:28 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 20:11:28 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 20:11:28 INFO - Using env: {'DISPLAY': ':0', 20:11:28 INFO - 'HOME': '/home/cltbld', 20:11:28 INFO - 'LANG': 'en_US.UTF-8', 20:11:28 INFO - 'LANGUAGE': 'en_US:en', 20:11:28 INFO - 'LOGNAME': 'cltbld', 20:11:28 INFO - 'MAIL': '/var/mail/cltbld', 20:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:28 INFO - 'MOZ_NO_REMOTE': '1', 20:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:28 INFO - 'NO_EM_RESTART': '1', 20:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:28 INFO - 'PWD': '/builds/slave/test', 20:11:28 INFO - 'SHELL': '/bin/bash', 20:11:28 INFO - 'SHLVL': '1', 20:11:28 INFO - 'TERM': 'linux', 20:11:28 INFO - 'TMOUT': '86400', 20:11:28 INFO - 'USER': 'cltbld', 20:11:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:28 INFO - '_': '/tools/buildbot/bin/python'} 20:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:29 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)) 20:11:29 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)) 20:11:29 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)) 20:11:29 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)) 20:11:29 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)) 20:11:29 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)) 20:11:29 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)) 20:11:29 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)) 20:11:29 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)) 20:11:29 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)) 20:11:29 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)) 20:11:29 INFO - Cleaning up... 20:11:29 INFO - Return code: 0 20:11:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:11:29 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')]} 20:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:29 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')]} 20:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:29 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 0x7ff23d506f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', '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 20:11:29 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 20:11:29 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 20:11:29 INFO - Using env: {'DISPLAY': ':0', 20:11:29 INFO - 'HOME': '/home/cltbld', 20:11:29 INFO - 'LANG': 'en_US.UTF-8', 20:11:29 INFO - 'LANGUAGE': 'en_US:en', 20:11:29 INFO - 'LOGNAME': 'cltbld', 20:11:29 INFO - 'MAIL': '/var/mail/cltbld', 20:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:29 INFO - 'MOZ_NO_REMOTE': '1', 20:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:29 INFO - 'NO_EM_RESTART': '1', 20:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:29 INFO - 'PWD': '/builds/slave/test', 20:11:29 INFO - 'SHELL': '/bin/bash', 20:11:29 INFO - 'SHLVL': '1', 20:11:29 INFO - 'TERM': 'linux', 20:11:29 INFO - 'TMOUT': '86400', 20:11:29 INFO - 'USER': 'cltbld', 20:11:29 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:29 INFO - '_': '/tools/buildbot/bin/python'} 20:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:11:29 INFO - Cleaning up... 20:11:29 INFO - Return code: 0 20:11:29 INFO - Running post-action listener: _resource_record_post_action 20:11:29 INFO - Running post-action listener: _start_resource_monitoring 20:11:29 INFO - Starting resource monitoring. 20:11:29 INFO - [mozharness: 2016-11-01 03:11:29.407311Z] Finished create-virtualenv step (success) 20:11:29 INFO - [mozharness: 2016-11-01 03:11:29.407779Z] Running install step. 20:11:29 INFO - Running pre-action listener: _resource_record_pre_action 20:11:29 INFO - Running main action method: install 20:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:11:29 INFO - Reading from file tmpfile_stdout 20:11:29 INFO - Detecting whether we're running mozinstall >=1.0... 20:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:11:29 INFO - Reading from file tmpfile_stdout 20:11:29 INFO - Output received: 20:11:29 INFO - Usage: mozinstall [options] installer 20:11:29 INFO - Options: 20:11:29 INFO - -h, --help show this help message and exit 20:11:29 INFO - -d DEST, --destination=DEST 20:11:29 INFO - Directory to install application into. [default: 20:11:29 INFO - "/builds/slave/test"] 20:11:29 INFO - --app=APP Application being installed. [default: firefox] 20:11:29 INFO - mkdir: /builds/slave/test/build/application 20:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:11:45 INFO - Reading from file tmpfile_stdout 20:11:45 INFO - Output received: 20:11:45 INFO - /builds/slave/test/build/application/firefox/firefox 20:11:45 INFO - Running post-action listener: _resource_record_post_action 20:11:45 INFO - [mozharness: 2016-11-01 03:11:45.797493Z] Finished install step (success) 20:11:45 INFO - [mozharness: 2016-11-01 03:11:45.797742Z] Running run-tests step. 20:11:45 INFO - Running pre-action listener: _resource_record_pre_action 20:11:45 INFO - Running main action method: run_tests 20:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:11:45 INFO - Python 2.7.3 20:11:45 INFO - Return code: 0 20:11:45 INFO - grabbing minidump binary from tooltool 20:11:45 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')]} 20:11:45 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 0x2cdaf60>, '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 0x2cdbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdc1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:11:45 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 20:11:45 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 20:11:45 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 20:11:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:11:45 INFO - Return code: 0 20:11:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:11:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:11:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:11:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:11:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 20:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 20:11:45 INFO - Using env: {'DISPLAY': ':0', 20:11:45 INFO - 'HOME': '/home/cltbld', 20:11:45 INFO - 'LANG': 'en_US.UTF-8', 20:11:45 INFO - 'LANGUAGE': 'en_US:en', 20:11:45 INFO - 'LOGNAME': 'cltbld', 20:11:45 INFO - 'MAIL': '/var/mail/cltbld', 20:11:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:11:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:45 INFO - 'MOZ_NO_REMOTE': '1', 20:11:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:11:45 INFO - 'NO_EM_RESTART': '1', 20:11:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:45 INFO - 'PWD': '/builds/slave/test', 20:11:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:11:45 INFO - 'SHELL': '/bin/bash', 20:11:45 INFO - 'SHLVL': '1', 20:11:45 INFO - 'TERM': 'linux', 20:11:45 INFO - 'TMOUT': '86400', 20:11:45 INFO - 'USER': 'cltbld', 20:11:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028', 20:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:45 INFO - '_': '/tools/buildbot/bin/python'} 20:11:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 20:11:46 INFO - mozversion application_buildid: 20161031183650 20:11:46 INFO - mozversion application_changeset: 62c5218b7325723c8d88d5c4cfe4fa241f905406 20:11:46 INFO - mozversion application_display_name: Nightly 20:11:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:11:46 INFO - mozversion application_name: Firefox 20:11:46 INFO - mozversion application_remotingname: firefox 20:11:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:11:46 INFO - mozversion application_vendor: Mozilla 20:11:46 INFO - mozversion application_version: 52.0a1 20:11:46 INFO - mozversion platform_buildid: 20161031183650 20:11:46 INFO - mozversion platform_changeset: 62c5218b7325723c8d88d5c4cfe4fa241f905406 20:11:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:11:46 INFO - mozversion platform_version: 52.0a1 20:11:46 INFO - using testdate: 1477969906 20:11:46 INFO - actual date: 1477969906 20:11:46 INFO - starting webserver on 'localhost:52296' 20:11:46 INFO - SUITE-START | Running 2 tests 20:11:46 INFO - TEST-START | dromaeo_css 20:11:46 INFO - operating with platform_type : linux_ 20:11:46 INFO - Initialising browser for dromaeo_css test... 20:11:46 INFO - TEST-INFO | started process 7441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCfkDP/profile http://localhost:52296/getInfo.html) 20:11:50 INFO - PROCESS | 7441 | __metrics Screen width/height:1600/1200 20:11:50 INFO - PROCESS | 7441 | colorDepth:24 20:11:50 INFO - PROCESS | 7441 | Browser inner width/height: 1024/697 20:11:50 INFO - PROCESS | 7441 | __metrics 20:11:51 INFO - PROCESS | 7441 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:11:51 INFO - PROCESS | 7441 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:11:52 INFO - TEST-INFO | 7441: exit 0 20:11:52 INFO - Browser initialized. 20:11:52 INFO - Running cycle 1/1 for dromaeo_css test... 20:11:52 INFO - TEST-INFO | started process 7521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCfkDP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:04 INFO - PROCESS | 7521 | RSS: Main: 175783936 20:12:04 INFO - PROCESS | 7521 | 20:12:56 INFO - PROCESS | 7521 | 1477969976052 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] 20:15:08 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:52296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52296/tests/dromaeo/cssquery-ext.html) 20:15:10 INFO - PROCESS | 7521 | RSS: Main: 353349632 20:15:10 INFO - PROCESS | 7521 | 20:18:13 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:52296/tests/dromaeo/cssquery-ext.html (next: http://localhost:52296/tests/dromaeo/cssquery-jquery.html) 20:18:14 INFO - PROCESS | 7521 | RSS: Main: 284041216 20:18:14 INFO - PROCESS | 7521 | 20:21:16 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:52296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52296/tests/dromaeo/cssquery-mootools.html) 20:21:17 INFO - PROCESS | 7521 | RSS: Main: 220123136 20:21:17 INFO - PROCESS | 7521 | 20:24:19 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:52296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52296/tests/dromaeo/cssquery-prototype.html) 20:24:20 INFO - PROCESS | 7521 | RSS: Main: 236879872 20:24:20 INFO - PROCESS | 7521 | 20:27:23 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:52296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52296/tests/dromaeo/cssquery-yui.html) 20:27:23 INFO - PROCESS | 7521 | RSS: Main: 219025408 20:27:23 INFO - PROCESS | 7521 | 20:30:26 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:52296/tests/dromaeo/cssquery-yui.html (next: http://localhost:52296/tests/dromaeo/cssquery-dojo.html) 20:30:27 INFO - PROCESS | 7521 | RSS: Main: 311214080 20:30:27 INFO - PROCESS | 7521 | 20:30:27 INFO - PROCESS | 7521 | __start_tp_report 20:30:27 INFO - PROCESS | 7521 | _x_x_mozilla_page_load 20:30:27 INFO - PROCESS | 7521 | _x_x_mozilla_page_load_details 20:30:27 INFO - PROCESS | 7521 | |i|pagename|runs| 20:30:27 INFO - PROCESS | 7521 | |0;dojo.html;2519.156082712291;2533.5312967101077;2565.12785652878;2566.499532591144;2578.7421257874225;4480.66395020374;4500.099980004;4506.571875671814;4511.14288285226;4561.133384656921;4507.819687212515;4558.088382323532;4573.3368661544055;4593.7243765374105;4658.953410465894;4147.066909945253;4162.313218318974;4213.578642135777;4218.261804184271;4222.662187025031;3870.632289932452;4247.426597409357;4255.4467919170465;4304;4353.934690979638;4081.08175660477;4237.8304867805255;4254.383114448418;4307.461567304087;4354.17270718564;4142.544320124784;4163.417121602978;4180.665546756252;4199.811008504625;4217.430646862665;4172.812223449952;4177.916441671149;4181.226473102486;4235.25882970479;4245;4515.458145022585;4528.841490547815;4536.954630453719;4545.159145558082;4602.332661764059;4747.192977193886;4804.9669321096135;4816.892114813612;4826.710397376169;4889.339939108246;4798.664093513456;4823.855284341475;4845.878853028667;4880.902381952341;4935.925961110586;4553.33976573395;4553.476350219701;4553.68124231304;4556.794944227518;4612.723236605814;4884.0476107159475;4968.801247950041;4971.950280497221;4990.426100998432;5037.748112594356;4697.412823397075;4746.572808447257;4795.712257264575;4808.807647694053;4809.807607695723;4816.8314109006715;4819.7108173509705;4824.252240902666;4889.315495830587;4949.257611358325;4843.564079232886;4855.5387238212315;4859.392575928009;4862.805487780449;4919.852404427873;4688.367070445446;4697.8355757548325;4756.429228492603;4797.544233297831;4844.878878028077;4219.78901054946;4243.469566304212;4243.766592837424;4291.013066994608;4293.914121717548;3658.122050707864;3697.7966211858607;3699.3341198584512;3731.104534911656;3737.588865224823;4082.8366865325647;4143.461350024478;4196.076863090116;4224.4508213931995;4229.513605935295;4858.58702010326;4873.439554451213;4915.827946021872;4923.729194894244;4939.950600494021;4196.664266858644;4198.475190601175;4201.852935147255;4252.659787217015;4256.042390462121;4349.9130017399475;4390.209762242827;4437.600615944581;4445.244308467568;4497.055618320124;4569.634429245719;4580.083983203439;4607.470140933836;4626.838060667995;4688.367070445583;4940.2342636891335;4963.131451995959;4964.398734177158;4969.950300497093;5023.045621331935;4614.907701845877;4634.026854360622;4643.373144625432;4644.489106198383;4705.882352941204;4680.7191568506;4738.810447582058;4741.57325840676;4780.856574302777;4806.158922188673;4802.471728109975;4852.199387101089;4853.975730121468;4854.708717476963;4856.805727770849;4733.242681170997;4738.526147385234;4741.739204343794;4742.336072949859;4744.383230180055;4733.408323959505;4777.546133117348;4798.7360695160705;4801.1117943180625;4860.343853579863;4678.508756580646;4726.71639701619;4733.5503127202865;4735.431748190239;4774.76126193682;4604.930926036179;4641.280601506772;4815.494373090775;4835.937693469729;4886;4607.861764147081;4618.214903466486;4673.859784206479;4676.7661616919695;4744.833930812405 20:30:27 INFO - PROCESS | 7521 | |1;ext.html;561.6237121128844;579.125520464099;581.0644861772546;585.3005658238407;599.3467120838285;28112.29719257017;38858.639947601805;40559.59440405595;40607;43567.3464898026;41589.7920510397;42105.368419473656;42274.78862605683;42289.36565951505;42350;7647.847043059135;7796.259355361231;7798.454108212427;7804.063512378522;7806.477736841318;7617.961910190469;7695.653695583712;7703.306702396783;7704.807379815494;7709.383249340068;7719.807004824868;7753.224677532258;7765.068191816961;7771.3782897368355;7771.611419429034;7688.5771282579435;7709.1134519530415;7740.458167928247;7741.651625676858;7744.6514906829325;7609.162992070867;7665.501742386727;7673.846523069563;7678.731244406475;7682.116556595951;38295.04262393463;38572;38699;38717.61282387196;38762.22475550473;2888.812227205246;2893.4068515954177;2902.2309088091674;2980.6125203723595;2982.7613790896676;27995.86002069997;28623.427531449463;28841;29294.26764330909;29885.25286867824;3487.4943133245793;3520.559930008749;3541.7166626669805;3597.1726502904216;3672.9632703672887;222212;222883;223022;223225;223297;31152.68847311543;52106.47893521092;52453.7377313111;52511.47488525066;52515.474845251825;31895.68104318927;31904.84047579747;32094.358112837614;32096.197595060312;32113.8394308027;13702.52041178554;13857.168569885838;13868.375923083486;13876.722465550834;13876.930615346859;10898.237123401286;10905.67282981496;10932.617358392417;10937.070349020423;10937.125029997582;7866.646000929972;7887.605619718991;7952.920470795334;8005.2795248426755;8089.069756978023;3087.38252349531;3103.239706271978;3110.6733792951413;3135.1064946490596;3139.8273094979995;820.33552822213;854.786303424144;892.7857314244665;952.1906379577442;962.8363178259713;26996.460070798475;27520.392809059857;27697.307567310978;27735.445291094467;27747.583786243224;793.7221972309761;888.7156110044724;906.845836207833;951.9666811661697;1010.8180527505119;13778.862211377958;14538.709225815424;14626.780598291034;14634.121952682874;14711;381620;383837;385711;385835;386052;49888;50400.747996259786;50420.24369634459;50427.49572504228;50778;1071.6195750508614;1105.4859490337033;1166.1603645375317;1178.7347846734417;1195.2947760821157;27087.86456067707;29132.563011555267;29391;29626.407471850875;29754;42435.1512969745;42921;42948;42993;43031.569684304006;283949;284010;285451;286645;286985;24289.51420971606;25067.623985639864;25149.37126571777;25573.74426255788;26575;41884.371734423396;41889.58110418857;41946.790266048476;42065.78967105145;42449.151016980104;35789.64210357863;35981.460278096376;36263.09342266464;36479.635203647624;37183.6281637191;35469.290614187055;36568.45147322739;37240.627593723715;37863;40140.59859401485;35888;36299;36399.27201456009;36690.44964325484;37124.62875371212;30527.236819079702;32976.67023329736;33196.66803331936;33466.83266583652;33496.1625959353;24836.875815620806;25089.24732258035;25279.36801579975;25382.50685272863;25870.87064564665 20:30:27 INFO - PROCESS | 7521 | |2;jquery.html;344.3663658867683;364.4424031232214;372.09580718853186;372.3223732806293;384.47327161788354;12204.511819527219;12444.453144881862;13719.17684938903;14575.27123643819;16874.325026998937;16681.49955501334;16775;17359.045252511107;17491;17496.650066998653;4727.787249573769;4999;5026.5727413169925;5029.3964724232965;5045.217991211368;3681.7975011374365;4846.733429661367;5053.418856831457;5053.949460505403;5054.848354549351;3835.712321575879;3886.9222615547674;4282.972086699186;5930.051191809312;6025.397460253984;5772.797952071699;5842.123681447795;5844.883102337972;5969.522438204933;5980.342162362137;6241.96879015602;6617.834554136137;6643.867122657568;6742.764003259862;6754.628495432749;22983;23050.88474557633;23759.1684291049;23767.881160594086;23948.88025559861;1958.3831093205738;1973.4178417366911;1996.8103030212108;2010.6179825833044;2506.7842096583145;13414.731705365837;13705.657358566015;13947.790783138262;15100.773488397683;15323.080615163126;1789.758382618343;1806.3226290141197;1812.8640351973654;1816.3824299738021;1850.2044121027952;78769;79509;81431;81730.59134704288;84760;15944.681106378039;16003.439879604159;16091.919540402223;16297.762581728835;16351.427700030441;28675.85662071718;28735;28870.85564572206;28872.978891477396;28975.275618109717;8569.657213711382;8732.65069397217;8761.386702930733;9034.412763170372;9111.544422778834;7203.96398018017;7223.494355395072;7224.891626625605;7381.741639042608;7416.703331866773;7930.365570754326;8179.059408168017;8283.213094755989;8295.58522073906;8443.662253509914;3172.254520187754;3203.7116659500757;3223.935521289561;3270.4767237241927;3295.505674148849;834.6285902773208;854.9358798090044;860.9569521523899;864.3478777437892;907.5190149220923;15166.924165379103;16564.337426502803;16677.49967500977;16755.83244167567;17473.301067957138;807.1565214351017;834.6953362022819;837.0833936839151;868;876.9342299327576;8911.240427572659;9402.96567377588;9594.42433453995;9624.37441566296;9669.129778319984;277143;372099;373820;374955;375738;58912;60079.39920600825;81500;82004;83324.16675833285;928.1831987850649;936.840737074699;947.3131979314942;948.3598570964709;957.4925289596525;15500;15914.761278581062;16240.67518649644;16426.589335266715;16443.26005329787;34912.65087349094;35145.64854351424;35243;36015.45976810298;37620;48582;49726;49747.50252497574;50326.74836625793;50708;6890.827729306808;7207.71169153228;7324.121105467165;7437.442191835526;7602.087749470099;10182.778066632052;10948;11142.164337674869;11286.492107855001;11531.481083351437;9610.135087842127;9895.25785566071;9905.653302134679;10034.297599167989;10170.8474372883;9552.283578731762;9716.368436051634;9774.951125244328;9877.209823214269;9977.700668979942;9788.80422391534;9816.26378021637;9824.607015719577;10048.598056077675;10476.109530689977;6965.965170174117;7028.964855175692;7051.153861536443;7053.118360204974;7158.785236442915;8207.302379297827;9913.702588922344;9975.20198384113;10250.692479225636;10416.895831041897 20:30:27 INFO - PROCESS | 7521 | |3;mootools.html;1340.7385559815834;1379.5102738527823;1420.2330741399637;1659.2533359988001;1661.152812065846;5943.970280148604;6150.354212807647;6292.622442653444;6723.495737819659;6730.259671436144;6317.873642527146;6527.053577231299;6530.379613936669;6726.495512836545;6733.831654208647;2088.9686654700154;2116.6613341865304;2118.353902059871;2118.608057509358;2120.7561130469962;1740.7040803063446;1785.410814431241;2044.323654603226;2084.1038353507984;2107.220328478465;2026.7061276114955;2083.760367557735;2097.286922446368;2103.379503046597;2113.5455876986443;2069.8447616428675;2076;2097.517570958688;2097.937061888138;2100.1074543319028;2042.3974927396305;2052.3432501599495;2053.856230063896;2055.2806517718677;2060.474578982365;6752.3922846944015;6780.186377634666;6805.3534914183565;6806.897896531556;6814.727410903558;4057.69567282455;4118.114605359862;4212.873613791591;4224.556421575752;4263.978680106579;2657.5747880339054;2727.481778462086;2824.8587570621385;2828.929276768097;2833.3624934389804;899.4378513429107;924.4638109896244;936.8313703533362;943.7593413679537;948.0519480519481;8742.650293988232;8746.606402711894;8747.387682862201;8751.34364922627;8763.693270735494;3516.6834984851484;3750.887473375803;3758.661720445173;3835.252125835491;3846.0384903774057;7611.771646850603;7615.6953721850505;7616.314531692175;7625.961870190725;7629.847403052019;4143.461350024538;4144.730592511477;4148.211839750437;4151.481064866892;4151.647109995623;3673.2837096765875;3820.6370394812448;3900.063984643722;3900.395438707005;3905;3200.9839950800097;3241.6596257393107;3289.802611843297;3325;3338.649441808575;1018.0938964321759;1067.882532921378;1128.114430172311;1164.1792536261914;1170.4966864248286;651.7653644687908;720.9243029481934;752.3492179264897;804.1275216390283;810.9716159934492;4433.7118087324225;4507.3689683444345;4521.751303678264;4534.954650453453;4640.187967105743;804.0742421899635;828.8383765165735;846.8856704344958;861.3066481482341;889.5507768576828;3166.4458719724416;3170.254990077376;3184.7611429142908;3206.502992036238;3234.560620523844;7435.814104647319;7921.801954951057;7938.04743430792;7942.563159026309;7948.244916732901;7886.5662388568035;7895.921040789519;7900.723474678359;7903.130655627876;7912.32745216663;6190.133381326618;6269.8746025079245;6279.152314437584;6280.497560195174;6293.1504246927;4514.503404625554;4519.5480451954545;4528.592426681615;4555.95213100982;4672.392588963413;7316.451266155166;7337.816554586178;7360.66876990526;7394.149672787483;7414.962925185339;7244.637768111468;7336.96331518339;7349.963250183715;7381.741639042608;7412.295831895961;5776.913346299725;5850.210221620197;5873.089671100986;5885.61743486672;5887.499562537232;6186.10301506288;6269.216347956505;6357.332480089709;6365.586236894587;6419.358064193543;5729.9713501432225;5745.109508026096;5775.133729940542;5816.1857339973285;5904.763809447574;5785.479306862402;5804.1874137619925;5836.854078648068;5872.94127058741;6050.304215015153;5256.474352564713;5348.598855085962;5349.358077030781;5349.812756553502;5369.731513424235;3917.177392747441;3990.8403663854283;4019.698522610757;4157.355609880473;4261.97869010653;4014.8193331299576;4087.6321131098343;4095.32427149517;4154.169166166718;4238.25830479671 20:30:27 INFO - PROCESS | 7521 | |4;prototype.html;278.6335968201814;284.52200303490133;291.87011779758;292.12654164049485;293.7018925790322;4545.568096087458;4657.743824089682;4697.177993851075;4711.976440117804;4718.41019872516;4551.476580193279;4562.201614717428;4616.653750968674;4656.371389862367;4656.9534304656945;3691.53855768029;3707.277080969212;3708.128589781406;3708.4993525873933;3710.591834898159;3695.722820788438;3713.848706900856;3732.496113024734;3733.2906747717984;3733.7199710021723;3566.92866142677;3645.981770091146;3664.8167591620445;3670.4127339625666;3678.7240956928204;3673.651003154696;3679.742418030739;3680.392735198702;3681.1533347330264;3684.2263124743836;3201.0236877752277;3203.2472368993267;3209.8555564999633;3211.9197020074453;3211.935761284785;4526.162659907927;4549.099294276997;4577.359169716209;4595.954040459586;4644.790984405709;4127.855525056609;4128.174365126986;4130.925959250587;4132.173565286925;4153.68847336451;4901.754912254409;4917.680350777224;4918.942427378131;4920.1635721927005;4973.403191616993;3488.4069708149677;3488.529048578435;3495.615482296945;3496.2657841853243;3500.474928760681;4858.5384388483035;5097.337346144977;5105.5149760772665;5111.76997035138;5188.377394712658;3481;3489.685928266468;3490.3193877194212;3495.8252087395526;3498.650134986532;3533.3639944809665;3538.5046093546925;3545.6986156177013;3554.413521768879;3557.982210088933;3990.461287726178;4103.138340948374;4134.751914885116;4135.31767258399;4140.37894315855;4900.848300649344;4924.8030078797165;4930.9506904930495;4933.753312334441;4939.728314942713;1163.5404015414033;1188.263276768409;1202.22456515547;1223.3271700564653;1239.9150743099788;827.5531213144834;830.5506890476158;842.7471758472434;850.8683451010141;851.565701492231;4346.130773845243;4348.608625223745;4351.238533256667;4351.628362542422;4351.97824010878;4981.825636102719;5015.010064985363;5023.392514395431;5053.46938571452;5054.444011158769;4289.533518227032;4302.548232435549;4303.892402689958;4310.870673879788;4331.935020974688;2361.5749165150437;2567.5121726871835;2668.8398696078298;2701.5002224588516;2705.8758874283594;4727.55088266621;4729.540638867769;4743.905121897543;4747.884247201905;4772.856814295576;5141.614378921596;5146.716930568779;5152.252923326097;5163.566228458033;5219.243209734567;4579.816807327669;4735.479097299363;4763.523647635208;4787.4494433139935;4788.138135135569;5119.795208191631;5125.5899528036925;5135.563477104488;5138.203578445347;5156.097682905552;4971.428285747185;5022.799088036584;5058.721770302669;5063.569596584184;5064.949350506447;4524.742185626344;4728.71627702339;4760.309755085563;4773.3531931483585;4783.545563171493;3637.472566477793;3640.7269454790467;3681.079730067483;3684.1894783147663;3712.758670686505;5056.974715126401;5091.261767043832;5094.337736094284;5105.1576489880235;5106.693598384109;4570.085982803519;4768.356271903249;4915.582175514978;4919.286703428054;4953.380827396575;4924.72913989734;4926.679765815211;4935.506449355179;4939.580135688507;4952.975235123801;4875.756682046055;4883.926741098958;4891.01913724942;4897.608191344612;4907.901841963212;4712.316714076371;4904.754762261944;4906.411230652345;4915.336429581961;5007.173816320412;4841.298011788342;4843.903121937471;4871.392440494699;4886.731229782396;4897.167481528078 20:30:27 INFO - PROCESS | 7521 | |5;yui.html;615.7813976038507;626.8119564130766;651.443016221131;701.9996504980402;707.1761397971362;12433.254004759721;13407.195568265886;13499.932500337509;13524.459021639123;13537.729245415087;12443.315617641027;12464.37678116095;12535.122541422104;12562.748745025094;12575.434105465252;613.595027281994;634.2705888228528;781.1992707474827;796.0845028217567;804.6580203413555;788.763370988704;788.8146285622875;790.4703848421543;791.1376599506536;791.2048391366698;849.587949844325;850.4769566716456;850.9659613615448;850.9787255318605;851.0085750101125;644.9322821103764;664.4949838123038;808.337163525909;830.8130670599128;834.8038211020405;615.4030590327375;618.4217756397783;618.6937465954381;620.6245221640933;620.9658468784215;12181.756364872654;12209.084318676134;12229.694257643541;12230.266184028987;12240.510379584806;11667.824982625267;11669.766604667944;11876.16866819323;11903.642890713292;11926.582569610022;10774.78450430987;10828.458577071115;11061.281016733887;11170.553177872875;11541.538338466535;3862.5944275851193;3871.2064026874705;3879.282332768447;3927.9018024549327;3968;46934.29598556059;47388.76305618484;47406.28890566644;48668.51331486711;48716.51283487155;9021.32340074497;9258.814823703487;9331.533423328807;9515.286353523514;9645.469499177612;16772.832271677373;16991.74512382315;17064.402745903833;17070.23183956725;17249.655006899793;6238.6880655967925;6270.31026587075;6322.841928951721;6357.809265722036;6463.25672547663;3540.309639620301;3615.493830863681;3664.6885014774043;3678.0620941659704;3762.811859407019;2647.417568135007;2734.9589756153673;3090.8763649454218;3232.6928941750966;3235.3691030248874;426.81860209411496;539.3716320486668;545.4109561673383;547.0972894723658;550.031943778944;547.9643823151562;550.1225545255311;568.7213265499876;599.754100818671;603.9396060393925;7135.571865688075;7297.89053164203;7523.172451030382;7758.262965018314;8020.919790802134;477.6322231881432;549.8404569432232;556.8079012740598;576.1588081401118;578.1120625114645;3675.8345874435713;3749.2126653403093;3806.162644218323;4011.659008984269;4018.819153138116;68594.62151394422;70802.29197707957;70942.64528677323;71394;72832.27167728255;63871.36128638654;65074;65447;65908;65996.77050057249;57154.42845571491;57949.420505794405;59576.70211648914;60099;60440.697796510736;7347.044884165024;7716.344110750649;7792.493487923267;7826.060872695085;7857.960710196412;31520.684793151773;38378;38590.228195435375;39239.41140882946;39704.60295397009;47275;52312;53026.20460693016;53159;54939;9394.154526092685;9641.662541811003;10540;10608.522616482123;10937.070349020105;11297.774044519228;11461.770764584828;11791.410429478663;11860.703482413008;12150.513979440724;9236;11107.115386536329;11180.329180249211;11228.66314010581;11296.774064518828;10635.787284254116;10974.506147223234;11237.3257604544;11430.542778289107;11670.241434306743;10573.841392379274;11179.776404471702;11660.766784664429;12059.638210853689;12254.326012069421;9084.364094513321;9763.707088787347;9855.556499957662;9889.208863291064;10426.582936682447;8774.912250877409;9680.41917484925;10073.647422340477;10195.847062293924;10297.3821570706 20:30:27 INFO - PROCESS | 7521 | __end_tp_report 20:30:27 INFO - PROCESS | 7521 | __start_cc_report 20:30:27 INFO - PROCESS | 7521 | _x_x_mozilla_cycle_collect,2059 20:30:27 INFO - PROCESS | 7521 | __end_cc_report 20:30:27 INFO - PROCESS | 7521 | __startTimestamp1477971027203__endTimestamp 20:30:27 INFO - PROCESS | 7521 | 20:30:27 INFO - PROCESS | 7521 | ------- Summary: start ------- 20:30:27 INFO - PROCESS | 7521 | Number of tests: 6 20:30:27 INFO - PROCESS | 7521 | 20:30:27 INFO - PROCESS | 7521 | [#0] dojo.html Cycles:165 Average:4511.67 Median:4634.03 stddev:460.45 (9.9%) stddev-sans-first:434.53 20:30:27 INFO - PROCESS | 7521 | Values: 2519.2 2533.5 2565.1 2566.5 2578.7 4480.7 4500.1 4506.6 4511.1 4561.1 4507.8 4558.1 4573.3 4593.7 4659.0 4147.1 4162.3 4213.6 4218.3 4222.7 3870.6 4247.4 4255.4 4304.0 4353.9 4081.1 4237.8 4254.4 4307.5 4354.2 4142.5 4163.4 4180.7 4199.8 4217.4 4172.8 4177.9 4181.2 4235.3 4245.0 4515.5 4528.8 4537.0 4545.2 4602.3 4747.2 4805.0 4816.9 4826.7 4889.3 4798.7 4823.9 4845.9 4880.9 4935.9 4553.3 4553.5 4553.7 4556.8 4612.7 4884.0 4968.8 4972.0 4990.4 5037.7 4697.4 4746.6 4795.7 4808.8 4809.8 4816.8 4819.7 4824.3 4889.3 4949.3 4843.6 4855.5 4859.4 4862.8 4919.9 4688.4 4697.8 4756.4 4797.5 4844.9 4219.8 4243.5 4243.8 4291.0 4293.9 3658.1 3697.8 3699.3 3731.1 3737.6 4082.8 4143.5 4196.1 4224.5 4229.5 4858.6 4873.4 4915.8 4923.7 4940.0 4196.7 4198.5 4201.9 4252.7 4256.0 4349.9 4390.2 4437.6 4445.2 4497.1 4569.6 4580.1 4607.5 4626.8 4688.4 4940.2 4963.1 4964.4 4970.0 5023.0 4614.9 4634.0 4643.4 4644.5 4705.9 4680.7 4738.8 4741.6 4780.9 4806.2 4802.5 4852.2 4854.0 4854.7 4856.8 4733.2 4738.5 4741.7 4742.3 4744.4 4733.4 4777.5 4798.7 4801.1 4860.3 4678.5 4726.7 4733.6 4735.4 4774.8 4604.9 4641.3 4815.5 4835.9 4886.0 4607.9 4618.2 4673.9 4676.8 4744.8 20:30:27 INFO - PROCESS | 7521 | 20:30:27 INFO - PROCESS | 7521 | [#1] ext.html Cycles:180 Average:44597.17 Median:36629.45 stddev:80427.02 (219.6%) stddev-sans-first:80584.68 20:30:27 INFO - PROCESS | 7521 | Values: 561.6 579.1 581.1 585.3 599.3 28112.3 38858.6 40559.6 40607.0 43567.3 41589.8 42105.4 42274.8 42289.4 42350.0 7647.8 7796.3 7798.5 7804.1 7806.5 7618.0 7695.7 7703.3 7704.8 7709.4 7719.8 7753.2 7765.1 7771.4 7771.6 7688.6 7709.1 7740.5 7741.7 7744.7 7609.2 7665.5 7673.8 7678.7 7682.1 38295.0 38572.0 38699.0 38717.6 38762.2 2888.8 2893.4 2902.2 2980.6 2982.8 27995.9 28623.4 28841.0 29294.3 29885.3 3487.5 3520.6 3541.7 3597.2 3673.0 222212.0 222883.0 223022.0 223225.0 223297.0 31152.7 52106.5 52453.7 52511.5 52515.5 31895.7 31904.8 32094.4 32096.2 32113.8 13702.5 13857.2 13868.4 13876.7 13876.9 10898.2 10905.7 10932.6 10937.1 10937.1 7866.6 7887.6 7952.9 8005.3 8089.1 3087.4 3103.2 3110.7 3135.1 3139.8 820.3 854.8 892.8 952.2 962.8 26996.5 27520.4 27697.3 27735.4 27747.6 793.7 888.7 906.8 952.0 1010.8 13778.9 14538.7 14626.8 14634.1 14711.0 381620.0 383837.0 385711.0 385835.0 386052.0 49888.0 50400.7 50420.2 50427.5 50778.0 1071.6 1105.5 1166.2 1178.7 1195.3 27087.9 29132.6 29391.0 29626.4 29754.0 42435.2 42921.0 42948.0 42993.0 43031.6 283949.0 284010.0 285451.0 286645.0 286985.0 24289.5 25067.6 25149.4 25573.7 26575.0 41884.4 41889.6 41946.8 42065.8 42449.2 35789.6 35981.5 36263.1 36479.6 37183.6 35469.3 36568.5 37240.6 37863.0 40140.6 35888.0 36299.0 36399.3 36690.4 37124.6 30527.2 32976.7 33196.7 33466.8 33496.2 24836.9 25089.2 25279.4 25382.5 25870.9 20:30:27 INFO - PROCESS | 7521 | 20:30:27 INFO - PROCESS | 7521 | [#2] jquery.html Cycles:180 Average:24361.80 Median:5012.79 stddev:59274.81 (1182.5%) stddev-sans-first:59413.66 20:30:27 INFO - PROCESS | 7521 | Values: 344.4 364.4 372.1 372.3 384.5 12204.5 12444.5 13719.2 14575.3 16874.3 16681.5 16775.0 17359.0 17491.0 17496.7 4727.8 4999.0 5026.6 5029.4 5045.2 3681.8 4846.7 5053.4 5053.9 5054.8 3835.7 3886.9 4283.0 5930.1 6025.4 5772.8 5842.1 5844.9 5969.5 5980.3 6242.0 6617.8 6643.9 6742.8 6754.6 22983.0 23050.9 23759.2 23767.9 23948.9 1958.4 1973.4 1996.8 2010.6 2506.8 13414.7 13705.7 13947.8 15100.8 15323.1 1789.8 1806.3 1812.9 1816.4 1850.2 78769.0 79509.0 81431.0 81730.6 84760.0 15944.7 16003.4 16091.9 16297.8 16351.4 28675.9 28735.0 28870.9 28873.0 28975.3 8569.7 8732.7 8761.4 9034.4 9111.5 7204.0 7223.5 7224.9 7381.7 7416.7 7930.4 8179.1 8283.2 8295.6 8443.7 3172.3 3203.7 3223.9 3270.5 3295.5 834.6 854.9 861.0 864.3 907.5 15166.9 16564.3 16677.5 16755.8 17473.3 807.2 834.7 837.1 868.0 876.9 8911.2 9403.0 9594.4 9624.4 9669.1 277143.0 372099.0 373820.0 374955.0 375738.0 58912.0 60079.4 81500.0 82004.0 83324.2 928.2 936.8 947.3 948.4 957.5 15500.0 15914.8 16240.7 16426.6 16443.3 34912.7 35145.6 35243.0 36015.5 37620.0 48582.0 49726.0 49747.5 50326.7 50708.0 6890.8 7207.7 7324.1 7437.4 7602.1 10182.8 10948.0 11142.2 11286.5 11531.5 9610.1 9895.3 9905.7 10034.3 10170.8 9552.3 9716.4 9775.0 9877.2 9977.7 9788.8 9816.3 9824.6 10048.6 10476.1 6966.0 7029.0 7051.2 7053.1 7158.8 8207.3 9913.7 9975.2 10250.7 10416.9 20:30:27 INFO - PROCESS | 7521 | 20:30:27 INFO - PROCESS | 7521 | [#3] mootools.html Cycles:180 Average:4439.50 Median:5302.54 stddev:2308.49 (43.5%) stddev-sans-first:2303.22 20:30:27 INFO - PROCESS | 7521 | Values: 1340.7 1379.5 1420.2 1659.3 1661.2 5944.0 6150.4 6292.6 6723.5 6730.3 6317.9 6527.1 6530.4 6726.5 6733.8 2089.0 2116.7 2118.4 2118.6 2120.8 1740.7 1785.4 2044.3 2084.1 2107.2 2026.7 2083.8 2097.3 2103.4 2113.5 2069.8 2076.0 2097.5 2097.9 2100.1 2042.4 2052.3 2053.9 2055.3 2060.5 6752.4 6780.2 6805.4 6806.9 6814.7 4057.7 4118.1 4212.9 4224.6 4264.0 2657.6 2727.5 2824.9 2828.9 2833.4 899.4 924.5 936.8 943.8 948.1 8742.7 8746.6 8747.4 8751.3 8763.7 3516.7 3750.9 3758.7 3835.3 3846.0 7611.8 7615.7 7616.3 7626.0 7629.8 4143.5 4144.7 4148.2 4151.5 4151.6 3673.3 3820.6 3900.1 3900.4 3905.0 3201.0 3241.7 3289.8 3325.0 3338.6 1018.1 1067.9 1128.1 1164.2 1170.5 651.8 720.9 752.3 804.1 811.0 4433.7 4507.4 4521.8 4535.0 4640.2 804.1 828.8 846.9 861.3 889.6 3166.4 3170.3 3184.8 3206.5 3234.6 7435.8 7921.8 7938.0 7942.6 7948.2 7886.6 7895.9 7900.7 7903.1 7912.3 6190.1 6269.9 6279.2 6280.5 6293.2 4514.5 4519.5 4528.6 4556.0 4672.4 7316.5 7337.8 7360.7 7394.1 7415.0 7244.6 7337.0 7350.0 7381.7 7412.3 5776.9 5850.2 5873.1 5885.6 5887.5 6186.1 6269.2 6357.3 6365.6 6419.4 5730.0 5745.1 5775.1 5816.2 5904.8 5785.5 5804.2 5836.9 5872.9 6050.3 5256.5 5348.6 5349.4 5349.8 5369.7 3917.2 3990.8 4019.7 4157.4 4262.0 4014.8 4087.6 4095.3 4154.2 4238.3 20:30:27 INFO - PROCESS | 7521 | 20:30:27 INFO - PROCESS | 7521 | [#4] prototype.html Cycles:180 Average:4078.29 Median:4630.72 stddev:1193.27 (25.8%) stddev-sans-first:1162.03 20:30:27 INFO - PROCESS | 7521 | Values: 278.6 284.5 291.9 292.1 293.7 4545.6 4657.7 4697.2 4712.0 4718.4 4551.5 4562.2 4616.7 4656.4 4657.0 3691.5 3707.3 3708.1 3708.5 3710.6 3695.7 3713.8 3732.5 3733.3 3733.7 3566.9 3646.0 3664.8 3670.4 3678.7 3673.7 3679.7 3680.4 3681.2 3684.2 3201.0 3203.2 3209.9 3211.9 3211.9 4526.2 4549.1 4577.4 4596.0 4644.8 4127.9 4128.2 4130.9 4132.2 4153.7 4901.8 4917.7 4918.9 4920.2 4973.4 3488.4 3488.5 3495.6 3496.3 3500.5 4858.5 5097.3 5105.5 5111.8 5188.4 3481.0 3489.7 3490.3 3495.8 3498.7 3533.4 3538.5 3545.7 3554.4 3558.0 3990.5 4103.1 4134.8 4135.3 4140.4 4900.8 4924.8 4931.0 4933.8 4939.7 1163.5 1188.3 1202.2 1223.3 1239.9 827.6 830.6 842.7 850.9 851.6 4346.1 4348.6 4351.2 4351.6 4352.0 4981.8 5015.0 5023.4 5053.5 5054.4 4289.5 4302.5 4303.9 4310.9 4331.9 2361.6 2567.5 2668.8 2701.5 2705.9 4727.6 4729.5 4743.9 4747.9 4772.9 5141.6 5146.7 5152.3 5163.6 5219.2 4579.8 4735.5 4763.5 4787.4 4788.1 5119.8 5125.6 5135.6 5138.2 5156.1 4971.4 5022.8 5058.7 5063.6 5064.9 4524.7 4728.7 4760.3 4773.4 4783.5 3637.5 3640.7 3681.1 3684.2 3712.8 5057.0 5091.3 5094.3 5105.2 5106.7 4570.1 4768.4 4915.6 4919.3 4953.4 4924.7 4926.7 4935.5 4939.6 4953.0 4875.8 4883.9 4891.0 4897.6 4907.9 4712.3 4904.8 4906.4 4915.3 5007.2 4841.3 4843.9 4871.4 4886.7 4897.2 20:30:27 INFO - PROCESS | 7521 | 20:30:27 INFO - PROCESS | 7521 | [#5] yui.html Cycles:180 Average:14918.57 Median:53092.60 stddev:19303.32 (36.4%) stddev-sans-first:19327.59 20:30:27 INFO - PROCESS | 7521 | Values: 615.8 626.8 651.4 702.0 707.2 12433.3 13407.2 13499.9 13524.5 13537.7 12443.3 12464.4 12535.1 12562.7 12575.4 613.6 634.3 781.2 796.1 804.7 788.8 788.8 790.5 791.1 791.2 849.6 850.5 851.0 851.0 851.0 644.9 664.5 808.3 830.8 834.8 615.4 618.4 618.7 620.6 621.0 12181.8 12209.1 12229.7 12230.3 12240.5 11667.8 11669.8 11876.2 11903.6 11926.6 10774.8 10828.5 11061.3 11170.6 11541.5 3862.6 3871.2 3879.3 3927.9 3968.0 46934.3 47388.8 47406.3 48668.5 48716.5 9021.3 9258.8 9331.5 9515.3 9645.5 16772.8 16991.7 17064.4 17070.2 17249.7 6238.7 6270.3 6322.8 6357.8 6463.3 3540.3 3615.5 3664.7 3678.1 3762.8 2647.4 2735.0 3090.9 3232.7 3235.4 426.8 539.4 545.4 547.1 550.0 548.0 550.1 568.7 599.8 603.9 7135.6 7297.9 7523.2 7758.3 8020.9 477.6 549.8 556.8 576.2 578.1 3675.8 3749.2 3806.2 4011.7 4018.8 68594.6 70802.3 70942.6 71394.0 72832.3 63871.4 65074.0 65447.0 65908.0 65996.8 57154.4 57949.4 59576.7 60099.0 60440.7 7347.0 7716.3 7792.5 7826.1 7858.0 31520.7 38378.0 38590.2 39239.4 39704.6 47275.0 52312.0 53026.2 53159.0 54939.0 9394.2 9641.7 10540.0 10608.5 10937.1 11297.8 11461.8 11791.4 11860.7 12150.5 9236.0 11107.1 11180.3 11228.7 11296.8 10635.8 10974.5 11237.3 11430.5 11670.2 10573.8 11179.8 11660.8 12059.6 12254.3 9084.4 9763.7 9855.6 9889.2 10426.6 8774.9 9680.4 10073.6 10195.8 10297.4 20:30:27 INFO - PROCESS | 7521 | -------- Summary: end -------- 20:30:27 INFO - PROCESS | 7521 | 20:30:28 INFO - TEST-INFO | 7521: exit 0 20:30:28 INFO - TEST-OK | dromaeo_css | took 1122052ms 20:30:28 INFO - TEST-START | kraken 20:30:28 INFO - operating with platform_type : linux_ 20:30:28 INFO - Initialising browser for kraken test... 20:30:28 INFO - TEST-INFO | started process 7826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsHGKoT/profile http://localhost:52296/getInfo.html) 20:30:32 INFO - PROCESS | 7826 | __metrics Screen width/height:1600/1200 20:30:32 INFO - PROCESS | 7826 | colorDepth:24 20:30:32 INFO - PROCESS | 7826 | Browser inner width/height: 1024/697 20:30:32 INFO - PROCESS | 7826 | __metrics 20:30:32 INFO - PROCESS | 7826 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:30:32 INFO - PROCESS | 7826 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:30:33 INFO - PROCESS | 7826 | console.error: PushService: 20:30:33 INFO - PROCESS | 7826 | stateChangeProcessEnqueue: Error transitioning state 20:30:33 INFO - PROCESS | 7826 | UnknownError 20:30:34 INFO - TEST-INFO | 7826: exit 0 20:30:34 INFO - Browser initialized. 20:30:34 INFO - Running cycle 1/1 for kraken test... 20:30:34 INFO - TEST-INFO | started process 7906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsHGKoT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:30:46 INFO - PROCESS | 7906 | RSS: Main: 176615424 20:30:46 INFO - PROCESS | 7906 | 20:30:49 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52296/tests/kraken/driver.html?testName=audio-beat-detection) 20:30:50 INFO - PROCESS | 7906 | RSS: Main: 232828928 20:30:50 INFO - PROCESS | 7906 | 20:30:53 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52296/tests/kraken/driver.html?testName=audio-dft) 20:30:53 INFO - PROCESS | 7906 | RSS: Main: 219144192 20:30:53 INFO - PROCESS | 7906 | 20:30:56 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52296/tests/kraken/driver.html?testName=audio-fft) 20:30:57 INFO - PROCESS | 7906 | RSS: Main: 301830144 20:30:57 INFO - PROCESS | 7906 | 20:30:59 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52296/tests/kraken/driver.html?testName=audio-oscillator) 20:31:00 INFO - PROCESS | 7906 | RSS: Main: 213164032 20:31:00 INFO - PROCESS | 7906 | 20:31:02 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:31:03 INFO - PROCESS | 7906 | RSS: Main: 215236608 20:31:03 INFO - PROCESS | 7906 | 20:31:06 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52296/tests/kraken/driver.html?testName=imaging-darkroom) 20:31:06 INFO - PROCESS | 7906 | RSS: Main: 251564032 20:31:06 INFO - PROCESS | 7906 | 20:31:10 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52296/tests/kraken/driver.html?testName=imaging-desaturate) 20:31:10 INFO - PROCESS | 7906 | RSS: Main: 250945536 20:31:10 INFO - PROCESS | 7906 | 20:31:13 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52296/tests/kraken/driver.html?testName=json-parse-financial) 20:31:14 INFO - PROCESS | 7906 | RSS: Main: 250241024 20:31:14 INFO - PROCESS | 7906 | 20:31:15 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:31:16 INFO - PROCESS | 7906 | RSS: Main: 212271104 20:31:16 INFO - PROCESS | 7906 | 20:31:18 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52296/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:31:19 INFO - PROCESS | 7906 | RSS: Main: 220053504 20:31:19 INFO - PROCESS | 7906 | 20:31:21 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:31:21 INFO - PROCESS | 7906 | RSS: Main: 228278272 20:31:21 INFO - PROCESS | 7906 | 20:31:24 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:31:25 INFO - PROCESS | 7906 | RSS: Main: 238063616 20:31:25 INFO - PROCESS | 7906 | 20:31:28 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:31:29 INFO - PROCESS | 7906 | RSS: Main: 234782720 20:31:29 INFO - PROCESS | 7906 | 20:31:30 INFO - PROCESS | 7906 | Cycle 1(1): loaded http://localhost:52296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52296/tests/kraken/driver.html?testName=ai-astar) 20:31:31 INFO - PROCESS | 7906 | RSS: Main: 286154752 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | __start_tp_report 20:31:31 INFO - PROCESS | 7906 | _x_x_mozilla_page_load 20:31:31 INFO - PROCESS | 7906 | _x_x_mozilla_page_load_details 20:31:31 INFO - PROCESS | 7906 | |i|pagename|runs| 20:31:31 INFO - PROCESS | 7906 | |0;ai-astar;111;117;116;117;117;117;118;116;118;118 20:31:31 INFO - PROCESS | 7906 | |1;audio-beat-detection;158;131;129;180;139;132;133;127;162;129 20:31:31 INFO - PROCESS | 7906 | |2;audio-dft;162;160;161;161;161;159;161;162;162;161 20:31:31 INFO - PROCESS | 7906 | |3;audio-fft;75;78;76;109;77;77;77;77;105;76 20:31:31 INFO - PROCESS | 7906 | |4;audio-oscillator;84;84;117;84;86;84;114;85;84;120 20:31:31 INFO - PROCESS | 7906 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;118;117 20:31:31 INFO - PROCESS | 7906 | |6;imaging-darkroom;146;146;147;147;148;146;147;146;147;149 20:31:31 INFO - PROCESS | 7906 | |7;imaging-desaturate;84;84;84;84;85;85;84;84;85;84 20:31:31 INFO - PROCESS | 7906 | |8;json-parse-financial;63;62;69;62;63;64;63;62;63;64 20:31:31 INFO - PROCESS | 7906 | |9;json-stringify-tinderbox;67;66;66;66;66;65;65;66;67;67 20:31:31 INFO - PROCESS | 7906 | |10;stanford-crypto-aes;84;84;84;85;83;86;90;83;84;92 20:31:31 INFO - PROCESS | 7906 | |11;stanford-crypto-ccm;146;143;156;142;141;145;152;137;189;139 20:31:31 INFO - PROCESS | 7906 | |12;stanford-crypto-pbkdf2;176;178;175;175;177;176;175;176;182;177 20:31:31 INFO - PROCESS | 7906 | |13;stanford-crypto-sha256-iterative;70;72;73;69;69;69;70;73;69;69 20:31:31 INFO - PROCESS | 7906 | __end_tp_report 20:31:31 INFO - PROCESS | 7906 | __start_cc_report 20:31:31 INFO - PROCESS | 7906 | _x_x_mozilla_cycle_collect,1969 20:31:31 INFO - PROCESS | 7906 | __end_cc_report 20:31:31 INFO - PROCESS | 7906 | __startTimestamp1477971091103__endTimestamp 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | ------- Summary: start ------- 20:31:31 INFO - PROCESS | 7906 | Number of tests: 14 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.00 stddev:2.07 (1.8%) stddev-sans-first:0.78 20:31:31 INFO - PROCESS | 7906 | Values: 111.0 117.0 116.0 117.0 117.0 117.0 118.0 116.0 118.0 118.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:136.00 stddev:18.18 (13.4%) stddev-sans-first:18.34 20:31:31 INFO - PROCESS | 7906 | Values: 158.0 131.0 129.0 180.0 139.0 132.0 133.0 127.0 162.0 129.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 20:31:31 INFO - PROCESS | 7906 | Values: 162.0 160.0 161.0 161.0 161.0 159.0 161.0 162.0 162.0 161.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:12.87 (16.7%) stddev-sans-first:13.34 20:31:31 INFO - PROCESS | 7906 | Values: 75.0 78.0 76.0 109.0 77.0 77.0 77.0 77.0 105.0 76.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:84.00 stddev:15.81 (18.8%) stddev-sans-first:16.33 20:31:31 INFO - PROCESS | 7906 | Values: 84.0 84.0 117.0 84.0 86.0 84.0 114.0 85.0 84.0 120.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:31:31 INFO - PROCESS | 7906 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 20:31:31 INFO - PROCESS | 7906 | Values: 146.0 146.0 147.0 147.0 148.0 146.0 147.0 146.0 147.0 149.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 20:31:31 INFO - PROCESS | 7906 | Values: 84.0 84.0 84.0 84.0 85.0 85.0 84.0 84.0 85.0 84.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.00 stddev:2.07 (3.3%) stddev-sans-first:2.19 20:31:31 INFO - PROCESS | 7906 | Values: 63.0 62.0 69.0 62.0 63.0 64.0 63.0 62.0 63.0 64.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 20:31:31 INFO - PROCESS | 7906 | Values: 67.0 66.0 66.0 66.0 66.0 65.0 65.0 66.0 67.0 67.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.50 stddev:3.06 (3.6%) stddev-sans-first:3.20 20:31:31 INFO - PROCESS | 7906 | Values: 84.0 84.0 84.0 85.0 83.0 86.0 90.0 83.0 84.0 92.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:145.50 stddev:15.19 (10.4%) stddev-sans-first:16.07 20:31:31 INFO - PROCESS | 7906 | Values: 146.0 143.0 156.0 142.0 141.0 145.0 152.0 137.0 189.0 139.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:176.50 stddev:2.11 (1.2%) stddev-sans-first:2.22 20:31:31 INFO - PROCESS | 7906 | Values: 176.0 178.0 175.0 175.0 177.0 176.0 175.0 176.0 182.0 177.0 20:31:31 INFO - PROCESS | 7906 | 20:31:31 INFO - PROCESS | 7906 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:1.70 (2.4%) stddev-sans-first:1.80 20:31:31 INFO - PROCESS | 7906 | Values: 70.0 72.0 73.0 69.0 69.0 69.0 70.0 73.0 69.0 69.0 20:31:31 INFO - PROCESS | 7906 | -------- Summary: end -------- 20:31:31 INFO - PROCESS | 7906 | 20:31:32 INFO - TEST-INFO | 7906: exit 0 20:31:32 INFO - TEST-OK | kraken | took 64243ms 20:31:32 INFO - SUITE-END | took 1186s 20:31:32 INFO - Completed test suite (00:19:46) 20:31:32 INFO - javascript benchmark 20:31:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2519.156082712291, 2533.5312967101077, 2565.12785652878, 2566.499532591144, 2578.7421257874225, 4480.66395020374, 4500.099980004, 4506.571875671814, 4511.14288285226, 4561.133384656921, 4507.819687212515, 4558.088382323532, 4573.3368661544055, 4593.7243765374105, 4658.953410465894, 4147.066909945253, 4162.313218318974, 4213.578642135777, 4218.261804184271, 4222.662187025031, 3870.632289932452, 4247.426597409357, 4255.4467919170465, 4304.0, 4353.934690979638, 4081.08175660477, 4237.8304867805255, 4254.383114448418, 4307.461567304087, 4354.17270718564, 4142.544320124784, 4163.417121602978, 4180.665546756252, 4199.811008504625, 4217.430646862665, 4172.812223449952, 4177.916441671149, 4181.226473102486, 4235.25882970479, 4245.0, 4515.458145022585, 4528.841490547815, 4536.954630453719, 4545.159145558082, 4602.332661764059, 4747.192977193886, 4804.9669321096135, 4816.892114813612, 4826.710397376169, 4889.339939108246, 4798.664093513456, 4823.855284341475, 4845.878853028667, 4880.902381952341, 4935.925961110586, 4553.33976573395, 4553.476350219701, 4553.68124231304, 4556.794944227518, 4612.723236605814, 4884.0476107159475, 4968.801247950041, 4971.950280497221, 4990.426100998432, 5037.748112594356, 4697.412823397075, 4746.572808447257, 4795.712257264575, 4808.807647694053, 4809.807607695723, 4816.8314109006715, 4819.7108173509705, 4824.252240902666, 4889.315495830587, 4949.257611358325, 4843.564079232886, 4855.5387238212315, 4859.392575928009, 4862.805487780449, 4919.852404427873, 4688.367070445446, 4697.8355757548325, 4756.429228492603, 4797.544233297831, 4844.878878028077, 4219.78901054946, 4243.469566304212, 4243.766592837424, 4291.013066994608, 4293.914121717548, 3658.122050707864, 3697.7966211858607, 3699.3341198584512, 3731.104534911656, 3737.588865224823, 4082.8366865325647, 4143.461350024478, 4196.076863090116, 4224.4508213931995, 4229.513605935295, 4858.58702010326, 4873.439554451213, 4915.827946021872, 4923.729194894244, 4939.950600494021, 4196.664266858644, 4198.475190601175, 4201.852935147255, 4252.659787217015, 4256.042390462121, 4349.9130017399475, 4390.209762242827, 4437.600615944581, 4445.244308467568, 4497.055618320124, 4569.634429245719, 4580.083983203439, 4607.470140933836, 4626.838060667995, 4688.367070445583, 4940.2342636891335, 4963.131451995959, 4964.398734177158, 4969.950300497093, 5023.045621331935, 4614.907701845877, 4634.026854360622, 4643.373144625432, 4644.489106198383, 4705.882352941204, 4680.7191568506, 4738.810447582058, 4741.57325840676, 4780.856574302777, 4806.158922188673, 4802.471728109975, 4852.199387101089, 4853.975730121468, 4854.708717476963, 4856.805727770849, 4733.242681170997, 4738.526147385234, 4741.739204343794, 4742.336072949859, 4744.383230180055, 4733.408323959505, 4777.546133117348, 4798.7360695160705, 4801.1117943180625, 4860.343853579863, 4678.508756580646, 4726.71639701619, 4733.5503127202865, 4735.431748190239, 4774.76126193682, 4604.930926036179, 4641.280601506772, 4815.494373090775, 4835.937693469729, 4886.0, 4607.861764147081, 4618.214903466486, 4673.859784206479, 4676.7661616919695, 4744.833930812405], "value": 4482.96398034521, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.6237121128844, 579.125520464099, 581.0644861772546, 585.3005658238407, 599.3467120838285, 28112.29719257017, 38858.639947601805, 40559.59440405595, 40607.0, 43567.3464898026, 41589.7920510397, 42105.368419473656, 42274.78862605683, 42289.36565951505, 42350.0, 7647.847043059135, 7796.259355361231, 7798.454108212427, 7804.063512378522, 7806.477736841318, 7617.961910190469, 7695.653695583712, 7703.306702396783, 7704.807379815494, 7709.383249340068, 7719.807004824868, 7753.224677532258, 7765.068191816961, 7771.3782897368355, 7771.611419429034, 7688.5771282579435, 7709.1134519530415, 7740.458167928247, 7741.651625676858, 7744.6514906829325, 7609.162992070867, 7665.501742386727, 7673.846523069563, 7678.731244406475, 7682.116556595951, 38295.04262393463, 38572.0, 38699.0, 38717.61282387196, 38762.22475550473, 2888.812227205246, 2893.4068515954177, 2902.2309088091674, 2980.6125203723595, 2982.7613790896676, 27995.86002069997, 28623.427531449463, 28841.0, 29294.26764330909, 29885.25286867824, 3487.4943133245793, 3520.559930008749, 3541.7166626669805, 3597.1726502904216, 3672.9632703672887, 222212.0, 222883.0, 223022.0, 223225.0, 223297.0, 31152.68847311543, 52106.47893521092, 52453.7377313111, 52511.47488525066, 52515.474845251825, 31895.68104318927, 31904.84047579747, 32094.358112837614, 32096.197595060312, 32113.8394308027, 13702.52041178554, 13857.168569885838, 13868.375923083486, 13876.722465550834, 13876.930615346859, 10898.237123401286, 10905.67282981496, 10932.617358392417, 10937.070349020423, 10937.125029997582, 7866.646000929972, 7887.605619718991, 7952.920470795334, 8005.2795248426755, 8089.069756978023, 3087.38252349531, 3103.239706271978, 3110.6733792951413, 3135.1064946490596, 3139.8273094979995, 820.33552822213, 854.786303424144, 892.7857314244665, 952.1906379577442, 962.8363178259713, 26996.460070798475, 27520.392809059857, 27697.307567310978, 27735.445291094467, 27747.583786243224, 793.7221972309761, 888.7156110044724, 906.845836207833, 951.9666811661697, 1010.8180527505119, 13778.862211377958, 14538.709225815424, 14626.780598291034, 14634.121952682874, 14711.0, 381620.0, 383837.0, 385711.0, 385835.0, 386052.0, 49888.0, 50400.747996259786, 50420.24369634459, 50427.49572504228, 50778.0, 1071.6195750508614, 1105.4859490337033, 1166.1603645375317, 1178.7347846734417, 1195.2947760821157, 27087.86456067707, 29132.563011555267, 29391.0, 29626.407471850875, 29754.0, 42435.1512969745, 42921.0, 42948.0, 42993.0, 43031.569684304006, 283949.0, 284010.0, 285451.0, 286645.0, 286985.0, 24289.51420971606, 25067.623985639864, 25149.37126571777, 25573.74426255788, 26575.0, 41884.371734423396, 41889.58110418857, 41946.790266048476, 42065.78967105145, 42449.151016980104, 35789.64210357863, 35981.460278096376, 36263.09342266464, 36479.635203647624, 37183.6281637191, 35469.290614187055, 36568.45147322739, 37240.627593723715, 37863.0, 40140.59859401485, 35888.0, 36299.0, 36399.27201456009, 36690.44964325484, 37124.62875371212, 30527.236819079702, 32976.67023329736, 33196.66803331936, 33466.83266583652, 33496.1625959353, 24836.875815620806, 25089.24732258035, 25279.36801579975, 25382.50685272863, 25870.87064564665], "value": 16299.379884166476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.3663658867683, 364.4424031232214, 372.09580718853186, 372.3223732806293, 384.47327161788354, 12204.511819527219, 12444.453144881862, 13719.17684938903, 14575.27123643819, 16874.325026998937, 16681.49955501334, 16775.0, 17359.045252511107, 17491.0, 17496.650066998653, 4727.787249573769, 4999.0, 5026.5727413169925, 5029.3964724232965, 5045.217991211368, 3681.7975011374365, 4846.733429661367, 5053.418856831457, 5053.949460505403, 5054.848354549351, 3835.712321575879, 3886.9222615547674, 4282.972086699186, 5930.051191809312, 6025.397460253984, 5772.797952071699, 5842.123681447795, 5844.883102337972, 5969.522438204933, 5980.342162362137, 6241.96879015602, 6617.834554136137, 6643.867122657568, 6742.764003259862, 6754.628495432749, 22983.0, 23050.88474557633, 23759.1684291049, 23767.881160594086, 23948.88025559861, 1958.3831093205738, 1973.4178417366911, 1996.8103030212108, 2010.6179825833044, 2506.7842096583145, 13414.731705365837, 13705.657358566015, 13947.790783138262, 15100.773488397683, 15323.080615163126, 1789.758382618343, 1806.3226290141197, 1812.8640351973654, 1816.3824299738021, 1850.2044121027952, 78769.0, 79509.0, 81431.0, 81730.59134704288, 84760.0, 15944.681106378039, 16003.439879604159, 16091.919540402223, 16297.762581728835, 16351.427700030441, 28675.85662071718, 28735.0, 28870.85564572206, 28872.978891477396, 28975.275618109717, 8569.657213711382, 8732.65069397217, 8761.386702930733, 9034.412763170372, 9111.544422778834, 7203.96398018017, 7223.494355395072, 7224.891626625605, 7381.741639042608, 7416.703331866773, 7930.365570754326, 8179.059408168017, 8283.213094755989, 8295.58522073906, 8443.662253509914, 3172.254520187754, 3203.7116659500757, 3223.935521289561, 3270.4767237241927, 3295.505674148849, 834.6285902773208, 854.9358798090044, 860.9569521523899, 864.3478777437892, 907.5190149220923, 15166.924165379103, 16564.337426502803, 16677.49967500977, 16755.83244167567, 17473.301067957138, 807.1565214351017, 834.6953362022819, 837.0833936839151, 868.0, 876.9342299327576, 8911.240427572659, 9402.96567377588, 9594.42433453995, 9624.37441566296, 9669.129778319984, 277143.0, 372099.0, 373820.0, 374955.0, 375738.0, 58912.0, 60079.39920600825, 81500.0, 82004.0, 83324.16675833285, 928.1831987850649, 936.840737074699, 947.3131979314942, 948.3598570964709, 957.4925289596525, 15500.0, 15914.761278581062, 16240.67518649644, 16426.589335266715, 16443.26005329787, 34912.65087349094, 35145.64854351424, 35243.0, 36015.45976810298, 37620.0, 48582.0, 49726.0, 49747.50252497574, 50326.74836625793, 50708.0, 6890.827729306808, 7207.71169153228, 7324.121105467165, 7437.442191835526, 7602.087749470099, 10182.778066632052, 10948.0, 11142.164337674869, 11286.492107855001, 11531.481083351437, 9610.135087842127, 9895.25785566071, 9905.653302134679, 10034.297599167989, 10170.8474372883, 9552.283578731762, 9716.368436051634, 9774.951125244328, 9877.209823214269, 9977.700668979942, 9788.80422391534, 9816.26378021637, 9824.607015719577, 10048.598056077675, 10476.109530689977, 6965.965170174117, 7028.964855175692, 7051.153861536443, 7053.118360204974, 7158.785236442915, 8207.302379297827, 9913.702588922344, 9975.20198384113, 10250.692479225636, 10416.895831041897], "value": 8877.38808855087, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.7385559815834, 1379.5102738527823, 1420.2330741399637, 1659.2533359988001, 1661.152812065846, 5943.970280148604, 6150.354212807647, 6292.622442653444, 6723.495737819659, 6730.259671436144, 6317.873642527146, 6527.053577231299, 6530.379613936669, 6726.495512836545, 6733.831654208647, 2088.9686654700154, 2116.6613341865304, 2118.353902059871, 2118.608057509358, 2120.7561130469962, 1740.7040803063446, 1785.410814431241, 2044.323654603226, 2084.1038353507984, 2107.220328478465, 2026.7061276114955, 2083.760367557735, 2097.286922446368, 2103.379503046597, 2113.5455876986443, 2069.8447616428675, 2076.0, 2097.517570958688, 2097.937061888138, 2100.1074543319028, 2042.3974927396305, 2052.3432501599495, 2053.856230063896, 2055.2806517718677, 2060.474578982365, 6752.3922846944015, 6780.186377634666, 6805.3534914183565, 6806.897896531556, 6814.727410903558, 4057.69567282455, 4118.114605359862, 4212.873613791591, 4224.556421575752, 4263.978680106579, 2657.5747880339054, 2727.481778462086, 2824.8587570621385, 2828.929276768097, 2833.3624934389804, 899.4378513429107, 924.4638109896244, 936.8313703533362, 943.7593413679537, 948.0519480519481, 8742.650293988232, 8746.606402711894, 8747.387682862201, 8751.34364922627, 8763.693270735494, 3516.6834984851484, 3750.887473375803, 3758.661720445173, 3835.252125835491, 3846.0384903774057, 7611.771646850603, 7615.6953721850505, 7616.314531692175, 7625.961870190725, 7629.847403052019, 4143.461350024538, 4144.730592511477, 4148.211839750437, 4151.481064866892, 4151.647109995623, 3673.2837096765875, 3820.6370394812448, 3900.063984643722, 3900.395438707005, 3905.0, 3200.9839950800097, 3241.6596257393107, 3289.802611843297, 3325.0, 3338.649441808575, 1018.0938964321759, 1067.882532921378, 1128.114430172311, 1164.1792536261914, 1170.4966864248286, 651.7653644687908, 720.9243029481934, 752.3492179264897, 804.1275216390283, 810.9716159934492, 4433.7118087324225, 4507.3689683444345, 4521.751303678264, 4534.954650453453, 4640.187967105743, 804.0742421899635, 828.8383765165735, 846.8856704344958, 861.3066481482341, 889.5507768576828, 3166.4458719724416, 3170.254990077376, 3184.7611429142908, 3206.502992036238, 3234.560620523844, 7435.814104647319, 7921.801954951057, 7938.04743430792, 7942.563159026309, 7948.244916732901, 7886.5662388568035, 7895.921040789519, 7900.723474678359, 7903.130655627876, 7912.32745216663, 6190.133381326618, 6269.8746025079245, 6279.152314437584, 6280.497560195174, 6293.1504246927, 4514.503404625554, 4519.5480451954545, 4528.592426681615, 4555.95213100982, 4672.392588963413, 7316.451266155166, 7337.816554586178, 7360.66876990526, 7394.149672787483, 7414.962925185339, 7244.637768111468, 7336.96331518339, 7349.963250183715, 7381.741639042608, 7412.295831895961, 5776.913346299725, 5850.210221620197, 5873.089671100986, 5885.61743486672, 5887.499562537232, 6186.10301506288, 6269.216347956505, 6357.332480089709, 6365.586236894587, 6419.358064193543, 5729.9713501432225, 5745.109508026096, 5775.133729940542, 5816.1857339973285, 5904.763809447574, 5785.479306862402, 5804.1874137619925, 5836.854078648068, 5872.94127058741, 6050.304215015153, 5256.474352564713, 5348.598855085962, 5349.358077030781, 5349.812756553502, 5369.731513424235, 3917.177392747441, 3990.8403663854283, 4019.698522610757, 4157.355609880473, 4261.97869010653, 4014.8193331299576, 4087.6321131098343, 4095.32427149517, 4154.169166166718, 4238.25830479671], "value": 3682.440422837993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.6335968201814, 284.52200303490133, 291.87011779758, 292.12654164049485, 293.7018925790322, 4545.568096087458, 4657.743824089682, 4697.177993851075, 4711.976440117804, 4718.41019872516, 4551.476580193279, 4562.201614717428, 4616.653750968674, 4656.371389862367, 4656.9534304656945, 3691.53855768029, 3707.277080969212, 3708.128589781406, 3708.4993525873933, 3710.591834898159, 3695.722820788438, 3713.848706900856, 3732.496113024734, 3733.2906747717984, 3733.7199710021723, 3566.92866142677, 3645.981770091146, 3664.8167591620445, 3670.4127339625666, 3678.7240956928204, 3673.651003154696, 3679.742418030739, 3680.392735198702, 3681.1533347330264, 3684.2263124743836, 3201.0236877752277, 3203.2472368993267, 3209.8555564999633, 3211.9197020074453, 3211.935761284785, 4526.162659907927, 4549.099294276997, 4577.359169716209, 4595.954040459586, 4644.790984405709, 4127.855525056609, 4128.174365126986, 4130.925959250587, 4132.173565286925, 4153.68847336451, 4901.754912254409, 4917.680350777224, 4918.942427378131, 4920.1635721927005, 4973.403191616993, 3488.4069708149677, 3488.529048578435, 3495.615482296945, 3496.2657841853243, 3500.474928760681, 4858.5384388483035, 5097.337346144977, 5105.5149760772665, 5111.76997035138, 5188.377394712658, 3481.0, 3489.685928266468, 3490.3193877194212, 3495.8252087395526, 3498.650134986532, 3533.3639944809665, 3538.5046093546925, 3545.6986156177013, 3554.413521768879, 3557.982210088933, 3990.461287726178, 4103.138340948374, 4134.751914885116, 4135.31767258399, 4140.37894315855, 4900.848300649344, 4924.8030078797165, 4930.9506904930495, 4933.753312334441, 4939.728314942713, 1163.5404015414033, 1188.263276768409, 1202.22456515547, 1223.3271700564653, 1239.9150743099788, 827.5531213144834, 830.5506890476158, 842.7471758472434, 850.8683451010141, 851.565701492231, 4346.130773845243, 4348.608625223745, 4351.238533256667, 4351.628362542422, 4351.97824010878, 4981.825636102719, 5015.010064985363, 5023.392514395431, 5053.46938571452, 5054.444011158769, 4289.533518227032, 4302.548232435549, 4303.892402689958, 4310.870673879788, 4331.935020974688, 2361.5749165150437, 2567.5121726871835, 2668.8398696078298, 2701.5002224588516, 2705.8758874283594, 4727.55088266621, 4729.540638867769, 4743.905121897543, 4747.884247201905, 4772.856814295576, 5141.614378921596, 5146.716930568779, 5152.252923326097, 5163.566228458033, 5219.243209734567, 4579.816807327669, 4735.479097299363, 4763.523647635208, 4787.4494433139935, 4788.138135135569, 5119.795208191631, 5125.5899528036925, 5135.563477104488, 5138.203578445347, 5156.097682905552, 4971.428285747185, 5022.799088036584, 5058.721770302669, 5063.569596584184, 5064.949350506447, 4524.742185626344, 4728.71627702339, 4760.309755085563, 4773.3531931483585, 4783.545563171493, 3637.472566477793, 3640.7269454790467, 3681.079730067483, 3684.1894783147663, 3712.758670686505, 5056.974715126401, 5091.261767043832, 5094.337736094284, 5105.1576489880235, 5106.693598384109, 4570.085982803519, 4768.356271903249, 4915.582175514978, 4919.286703428054, 4953.380827396575, 4924.72913989734, 4926.679765815211, 4935.506449355179, 4939.580135688507, 4952.975235123801, 4875.756682046055, 4883.926741098958, 4891.01913724942, 4897.608191344612, 4907.901841963212, 4712.316714076371, 4904.754762261944, 4906.411230652345, 4915.336429581961, 5007.173816320412, 4841.298011788342, 4843.903121937471, 4871.392440494699, 4886.731229782396, 4897.167481528078], "value": 3696.900386713477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.7813976038507, 626.8119564130766, 651.443016221131, 701.9996504980402, 707.1761397971362, 12433.254004759721, 13407.195568265886, 13499.932500337509, 13524.459021639123, 13537.729245415087, 12443.315617641027, 12464.37678116095, 12535.122541422104, 12562.748745025094, 12575.434105465252, 613.595027281994, 634.2705888228528, 781.1992707474827, 796.0845028217567, 804.6580203413555, 788.763370988704, 788.8146285622875, 790.4703848421543, 791.1376599506536, 791.2048391366698, 849.587949844325, 850.4769566716456, 850.9659613615448, 850.9787255318605, 851.0085750101125, 644.9322821103764, 664.4949838123038, 808.337163525909, 830.8130670599128, 834.8038211020405, 615.4030590327375, 618.4217756397783, 618.6937465954381, 620.6245221640933, 620.9658468784215, 12181.756364872654, 12209.084318676134, 12229.694257643541, 12230.266184028987, 12240.510379584806, 11667.824982625267, 11669.766604667944, 11876.16866819323, 11903.642890713292, 11926.582569610022, 10774.78450430987, 10828.458577071115, 11061.281016733887, 11170.553177872875, 11541.538338466535, 3862.5944275851193, 3871.2064026874705, 3879.282332768447, 3927.9018024549327, 3968.0, 46934.29598556059, 47388.76305618484, 47406.28890566644, 48668.51331486711, 48716.51283487155, 9021.32340074497, 9258.814823703487, 9331.533423328807, 9515.286353523514, 9645.469499177612, 16772.832271677373, 16991.74512382315, 17064.402745903833, 17070.23183956725, 17249.655006899793, 6238.6880655967925, 6270.31026587075, 6322.841928951721, 6357.809265722036, 6463.25672547663, 3540.309639620301, 3615.493830863681, 3664.6885014774043, 3678.0620941659704, 3762.811859407019, 2647.417568135007, 2734.9589756153673, 3090.8763649454218, 3232.6928941750966, 3235.3691030248874, 426.81860209411496, 539.3716320486668, 545.4109561673383, 547.0972894723658, 550.031943778944, 547.9643823151562, 550.1225545255311, 568.7213265499876, 599.754100818671, 603.9396060393925, 7135.571865688075, 7297.89053164203, 7523.172451030382, 7758.262965018314, 8020.919790802134, 477.6322231881432, 549.8404569432232, 556.8079012740598, 576.1588081401118, 578.1120625114645, 3675.8345874435713, 3749.2126653403093, 3806.162644218323, 4011.659008984269, 4018.819153138116, 68594.62151394422, 70802.29197707957, 70942.64528677323, 71394.0, 72832.27167728255, 63871.36128638654, 65074.0, 65447.0, 65908.0, 65996.77050057249, 57154.42845571491, 57949.420505794405, 59576.70211648914, 60099.0, 60440.697796510736, 7347.044884165024, 7716.344110750649, 7792.493487923267, 7826.060872695085, 7857.960710196412, 31520.684793151773, 38378.0, 38590.228195435375, 39239.41140882946, 39704.60295397009, 47275.0, 52312.0, 53026.20460693016, 53159.0, 54939.0, 9394.154526092685, 9641.662541811003, 10540.0, 10608.522616482123, 10937.070349020105, 11297.774044519228, 11461.770764584828, 11791.410429478663, 11860.703482413008, 12150.513979440724, 9236.0, 11107.115386536329, 11180.329180249211, 11228.66314010581, 11296.774064518828, 10635.787284254116, 10974.506147223234, 11237.3257604544, 11430.542778289107, 11670.241434306743, 10573.841392379274, 11179.776404471702, 11660.766784664429, 12059.638210853689, 12254.326012069421, 9084.364094513321, 9763.707088787347, 9855.556499957662, 9889.208863291064, 10426.582936682447, 8774.912250877409, 9680.41917484925, 10073.647422340477, 10195.847062293924, 10297.3821570706], "value": 6157.856841667638, "unit": "score"}], "name": "dromaeo_css", "value": 6155.262866632642, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 116.0, 118.0, 118.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 129.0, 180.0, 139.0, 132.0, 133.0, 127.0, 162.0, 129.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 161.0, 159.0, 161.0, 162.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 109.0, 77.0, 77.0, 77.0, 77.0, 105.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 84.0, 86.0, 84.0, 114.0, 85.0, 84.0, 120.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 149.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 69.0, 62.0, 63.0, 64.0, 63.0, 62.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 67.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 83.0, 86.0, 90.0, 83.0, 84.0, 92.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 156.0, 142.0, 141.0, 145.0, 152.0, 137.0, 189.0, 139.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 175.0, 175.0, 177.0, 176.0, 175.0, 176.0, 182.0, 177.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 73.0, 69.0, 69.0, 69.0, 70.0, 73.0, 69.0, 69.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1555.8999999999999, "alertThreshold": 2.0}]} 20:31:32 INFO - Return code: 0 20:31:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:31:32 INFO - # TBPL SUCCESS # 20:31:32 INFO - Running post-action listener: _resource_record_post_action 20:31:32 INFO - [mozharness: 2016-11-01 03:31:32.900094Z] Finished run-tests step (success) 20:31:32 INFO - Running post-run listener: _resource_record_post_run 20:31:32 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404336640; Read time: 16; Write time: 291004 20:31:32 INFO - TinderboxPrint: CPU usage
13.0% 20:31:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:31:32 INFO - TinderboxPrint: I/O write bytes / time
404,336,640 / 291,004 20:31:32 INFO - TinderboxPrint: CPU idle
8,347.8 (87.0%) 20:31:32 INFO - TinderboxPrint: CPU user
1,202.0 (12.5%) 20:31:32 INFO - TinderboxPrint: Swap in / out
0 / 0 20:31:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110968832; Read time: 0; Write time: 97080 20:31:33 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293367808; Read time: 0; Write time: 193924 20:31:33 INFO - Running post-run listener: _upload_blobber_files 20:31:33 INFO - Blob upload gear active. 20:31:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:31:33 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 20:31:33 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:31:33 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:31:33 INFO - (blobuploader) - INFO - Open directory for files ... 20:31:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:31:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:37 INFO - (blobuploader) - INFO - Done attempting. 20:31:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:31:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:38 INFO - (blobuploader) - INFO - Done attempting. 20:31:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:31:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:38 INFO - (blobuploader) - INFO - Done attempting. 20:31:38 INFO - (blobuploader) - INFO - Iteration through files over. 20:31:38 INFO - Return code: 0 20:31:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:31:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:31:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78d0e36a05c29f371c901ea6642dc9e45c22d2bf5bfeede2328c3ae62f760064dcec00c3384bfb08e50b139e7d1c6bb82f793ee60b2ecb62c2d25eb0496222f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77434d74978584c7a1555e6770f9a3e5ea60c030197571a5355350c15f25889734d4e4b644ecb22bb4bbed07dfafa7618fd8e33a047f6369816836567d5d8eb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b3899c256d7a5e66434c3065465c7b93f638cbeee39a4072995890be43914df56b2c78538a52569764e6b70c54c74dc2cb04d8d9564a19529ab5bc798f62887"} 20:31:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:31:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:31:38 INFO - Contents: 20:31:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78d0e36a05c29f371c901ea6642dc9e45c22d2bf5bfeede2328c3ae62f760064dcec00c3384bfb08e50b139e7d1c6bb82f793ee60b2ecb62c2d25eb0496222f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77434d74978584c7a1555e6770f9a3e5ea60c030197571a5355350c15f25889734d4e4b644ecb22bb4bbed07dfafa7618fd8e33a047f6369816836567d5d8eb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b3899c256d7a5e66434c3065465c7b93f638cbeee39a4072995890be43914df56b2c78538a52569764e6b70c54c74dc2cb04d8d9564a19529ab5bc798f62887"} 20:31:38 INFO - Running post-run listener: copy_logs_to_upload_dir 20:31:38 INFO - Copying logs to upload dir... 20:31:38 INFO - mkdir: /builds/slave/test/build/upload/logs 20:31:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.885089 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-31 20:31:38.776371) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 20:31:38.780120) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78d0e36a05c29f371c901ea6642dc9e45c22d2bf5bfeede2328c3ae62f760064dcec00c3384bfb08e50b139e7d1c6bb82f793ee60b2ecb62c2d25eb0496222f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77434d74978584c7a1555e6770f9a3e5ea60c030197571a5355350c15f25889734d4e4b644ecb22bb4bbed07dfafa7618fd8e33a047f6369816836567d5d8eb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b3899c256d7a5e66434c3065465c7b93f638cbeee39a4072995890be43914df56b2c78538a52569764e6b70c54c74dc2cb04d8d9564a19529ab5bc798f62887"} build_url:https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/Znt_BQ70SiCoyoJty8Dzog/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78d0e36a05c29f371c901ea6642dc9e45c22d2bf5bfeede2328c3ae62f760064dcec00c3384bfb08e50b139e7d1c6bb82f793ee60b2ecb62c2d25eb0496222f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77434d74978584c7a1555e6770f9a3e5ea60c030197571a5355350c15f25889734d4e4b644ecb22bb4bbed07dfafa7618fd8e33a047f6369816836567d5d8eb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b3899c256d7a5e66434c3065465c7b93f638cbeee39a4072995890be43914df56b2c78538a52569764e6b70c54c74dc2cb04d8d9564a19529ab5bc798f62887"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 20:31:38.812076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:31:38.812678) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1477969851.179568-1299331028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:31:38.896126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 20:31:38.896549) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 20:31:38.896928) ========= ========= Total master_lag: 0.19 =========