builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1476725520.86 results: success (0) buildid: 20161017073002 builduid: 7a4bd5ee0377437f9a4ce73dde3543ec revision: 7c8216f48c38a8498f251fe044509b930af44de6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:00.861410) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:00.861970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:00.862300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:00.902352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:00.902769) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 10:32:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-10-17 10:32:01 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.232717 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:01.150026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:01.150365) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019992 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:01.200751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:01.201214) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7c8216f48c38a8498f251fe044509b930af44de6 --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 7c8216f48c38a8498f251fe044509b930af44de6 --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=82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 10:32:01,253 truncating revision to first 12 chars 2016-10-17 10:32:01,253 Setting DEBUG logging. 2016-10-17 10:32:01,253 attempt 1/10 2016-10-17 10:32:01,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7c8216f48c38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 10:32:01,847 unpacking tar archive at: mozilla-central-7c8216f48c38/testing/mozharness/ program finished with exit code 0 elapsedTime=0.890739 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:02.106038) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:02.106394) ========= script_repo_revision: 7c8216f48c38a8498f251fe044509b930af44de6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:02.106783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:02.107090) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 10:32:02.117985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-17 10:32:02.118394) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:32:02 INFO - MultiFileLogger online at 20161017 10:32:02 in /builds/slave/test 10:32:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:32:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:32:02 INFO - {'append_to_log': False, 10:32:02 INFO - 'base_work_dir': '/builds/slave/test', 10:32:02 INFO - 'blob_upload_branch': 'Firefox', 10:32:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:32:02 INFO - 'branch': 'Firefox', 10:32:02 INFO - 'buildbot_json_path': 'buildprops.json', 10:32:02 INFO - 'config_files': ('talos/linux_config.py',), 10:32:02 INFO - 'default_actions': ('clobber', 10:32:02 INFO - 'read-buildbot-config', 10:32:02 INFO - 'download-and-extract', 10:32:02 INFO - 'populate-webroot', 10:32:02 INFO - 'create-virtualenv', 10:32:02 INFO - 'install', 10:32:02 INFO - 'run-tests'), 10:32:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:32:02 INFO - 'download_minidump_stackwalk': True, 10:32:02 INFO - 'download_symbols': 'ondemand', 10:32:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:32:02 INFO - 'tooltool.py': '/tools/tooltool.py', 10:32:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:32:02 INFO - '/tools/misc-python/virtualenv.py')}, 10:32:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:32:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:32:02 INFO - 'installer_path': 'installer.exe', 10:32:02 INFO - 'log_level': 'info', 10:32:02 INFO - 'log_name': 'talos', 10:32:02 INFO - 'log_to_console': True, 10:32:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:32:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:32:02 INFO - 'opt_config_files': (), 10:32:02 INFO - 'pip_index': False, 10:32:02 INFO - 'sps_profile': False, 10:32:02 INFO - 'sps_profile_interval': 0, 10:32:02 INFO - 'suite': 'dromaeojs', 10:32:02 INFO - 'system_bits': '32', 10:32:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:32:02 INFO - 'title': 'talos-linux64-ix-066', 10:32:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:32:02 INFO - 'use_talos_json': True, 10:32:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:32:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:32:02 INFO - 'work_dir': 'build'} 10:32:02 INFO - [mozharness: 2016-10-17 17:32:02.353824Z] Running clobber step. 10:32:02 INFO - Running pre-action listener: _resource_record_pre_action 10:32:02 INFO - Running main action method: clobber 10:32:02 INFO - rmtree: /builds/slave/test/build 10:32:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:32:02 INFO - Running post-action listener: _resource_record_post_action 10:32:02 INFO - [mozharness: 2016-10-17 17:32:02.779061Z] Finished clobber step (success) 10:32:02 INFO - [mozharness: 2016-10-17 17:32:02.779162Z] Running read-buildbot-config step. 10:32:02 INFO - Running pre-action listener: _resource_record_pre_action 10:32:02 INFO - Running main action method: read_buildbot_config 10:32:02 INFO - Using buildbot properties: 10:32:02 INFO - { 10:32:02 INFO - "project": "", 10:32:02 INFO - "product": "firefox", 10:32:02 INFO - "script_repo_revision": "production", 10:32:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:32:02 INFO - "repository": "", 10:32:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:32:02 INFO - "buildid": "20161017073002", 10:32:02 INFO - "pgo_build": "True", 10:32:02 INFO - "basedir": "/builds/slave/test", 10:32:02 INFO - "buildnumber": 40, 10:32:02 INFO - "slavename": "talos-linux64-ix-066", 10:32:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:32:02 INFO - "platform": "ubuntu64_hw", 10:32:02 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:32:02 INFO - "branch": "mozilla-central", 10:32:02 INFO - "repo_path": "mozilla-central", 10:32:02 INFO - "revision": "7c8216f48c38a8498f251fe044509b930af44de6", 10:32:02 INFO - "stage_platform": "linux64-pgo", 10:32:02 INFO - "builduid": "7a4bd5ee0377437f9a4ce73dde3543ec", 10:32:02 INFO - "slavebuilddir": "test" 10:32:02 INFO - } 10:32:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:32:02 INFO - Running post-action listener: _resource_record_post_action 10:32:02 INFO - [mozharness: 2016-10-17 17:32:02.781588Z] Finished read-buildbot-config step (success) 10:32:02 INFO - [mozharness: 2016-10-17 17:32:02.781676Z] Running download-and-extract step. 10:32:02 INFO - Running pre-action listener: _resource_record_pre_action 10:32:02 INFO - Running main action method: download_and_extract 10:32:02 INFO - mkdir: /builds/slave/test/build/tests 10:32:02 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')]} 10:32:02 INFO - trying https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:32:02 INFO - Downloading https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/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 10:32:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/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 10:32:03 INFO - Downloaded 1361 bytes. 10:32:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:32:03 INFO - Using the following test package requirements: 10:32:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:32:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:32:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:32:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:03 INFO - u'jsshell-linux-x86_64.zip'], 10:32:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:32:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:32:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:32:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:32:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:32:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:32:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:32:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:32:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:32:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:32:03 INFO - Fetch https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:32:04 INFO - Http code: 200 10:32:04 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 10:32:04 INFO - x-amz-cf-id: N2WmIjuCMY_acFtPhTzi22lFk6xXsX0Ie0dDYAgPcm4nqnYuL-ThpA== 10:32:04 INFO - x-amz-version-id: BSlvSo4hKRMJq3cHbF1mR1s655TvfpkS 10:32:04 INFO - Expected file size: 22089210 10:32:04 INFO - Obtained file size: 22089210 10:32:08 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 10:32:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:32:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:32:08 INFO - Fetch https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:32:09 INFO - Http code: 200 10:32:09 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 10:32:09 INFO - x-amz-cf-id: kBwRc3Yw9fZBYEJe2MTZpZNH-05sPm1C7jLxsQPD03xzfEZ9ajA_Cg== 10:32:09 INFO - x-amz-version-id: BSlvSo4hKRMJq3cHbF1mR1s655TvfpkS 10:32:09 INFO - Expected file size: 22089210 10:32:09 INFO - Obtained file size: 22089210 10:32:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:32:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:32:14 INFO - Fetch https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:32:14 INFO - Http code: 200 10:32:14 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 10:32:14 INFO - x-amz-cf-id: RKBNKaKDHfFW8mJCeuw-YbkV1ffaijplkUiTkCw-lAI3GizL_Y5o6Q== 10:32:14 INFO - x-amz-version-id: J2PtTzAM4VuMfmDsDH.eBI7gvGeBPHx6 10:32:14 INFO - Expected file size: 14409028 10:32:14 INFO - Obtained file size: 14409028 10:32: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')]} 10:32:15 INFO - trying https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:32:15 INFO - Downloading https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/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 10:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/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 10:32:16 INFO - Downloaded 59483541 bytes. 10:32:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:32:16 INFO - mkdir: /builds/slave/test/properties 10:32:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:32:16 INFO - Writing to file /builds/slave/test/properties/build_url 10:32:16 INFO - Contents: 10:32:16 INFO - build_url:https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:32:16 INFO - Running post-action listener: _resource_record_post_action 10:32:16 INFO - Running post-action listener: set_extra_try_arguments 10:32:16 INFO - [mozharness: 2016-10-17 17:32:16.965709Z] Finished download-and-extract step (success) 10:32:16 INFO - [mozharness: 2016-10-17 17:32:16.966010Z] Running populate-webroot step. 10:32:16 INFO - Running pre-action listener: _resource_record_pre_action 10:32:16 INFO - Running main action method: populate_webroot 10:32:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:32:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:32:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:32:16 INFO - '--tppagecycles', 10:32:16 INFO - '7'], 10:32:16 INFO - 'tests': ['tsvgm']}}, 10:32:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:32:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:32:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:32:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:32:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:16 INFO - 'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:16 INFO - 'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['damp', 'tps']}, 10:32:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:16 INFO - 'tests': ['damp', 'tps']}, 10:32:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['dromaeo_dom']}, 10:32:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:32:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['basic_compositor_video']}, 10:32:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:32:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['a11yr', 10:32:16 INFO - 'ts_paint', 10:32:16 INFO - 'tpaint', 10:32:16 INFO - 'sessionrestore', 10:32:16 INFO - 'sessionrestore_no_auto_restore', 10:32:16 INFO - 'tabpaint']}, 10:32:16 INFO - 'other-e10s': {'tests': ['a11yr', 10:32:16 INFO - 'ts_paint', 10:32:16 INFO - 'tpaint', 10:32:16 INFO - 'sessionrestore', 10:32:16 INFO - 'sessionrestore_no_auto_restore', 10:32:16 INFO - 'tabpaint']}, 10:32:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:32:16 INFO - 'ts_paint', 10:32:16 INFO - 'tpaint', 10:32:16 INFO - 'sessionrestore', 10:32:16 INFO - 'sessionrestore_no_auto_restore', 10:32:16 INFO - 'tabpaint']}, 10:32:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:32:16 INFO - 'ts_paint', 10:32:16 INFO - 'tpaint', 10:32:16 INFO - 'sessionrestore', 10:32:16 INFO - 'sessionrestore_no_auto_restore', 10:32:16 INFO - 'tabpaint']}, 10:32:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['a11yr', 10:32:16 INFO - 'ts_paint', 10:32:16 INFO - 'tpaint', 10:32:16 INFO - 'sessionrestore', 10:32:16 INFO - 'sessionrestore_no_auto_restore', 10:32:16 INFO - 'tabpaint']}, 10:32:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['a11yr', 10:32:16 INFO - 'ts_paint', 10:32:16 INFO - 'tpaint', 10:32:16 INFO - 'sessionrestore', 10:32:16 INFO - 'sessionrestore_no_auto_restore', 10:32:16 INFO - 'tabpaint']}, 10:32:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['tsvgx', 10:32:16 INFO - 'tsvgr_opacity', 10:32:16 INFO - 'tart', 10:32:16 INFO - 'tscrollx', 10:32:16 INFO - 'cart']}, 10:32:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:32:16 INFO - 'tsvgr_opacity', 10:32:16 INFO - 'tart', 10:32:16 INFO - 'tscrollx', 10:32:16 INFO - 'cart']}, 10:32:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:16 INFO - 'talos_options': ['--disable-e10s'], 10:32:16 INFO - 'tests': ['tp5o']}, 10:32:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:16 INFO - 'tests': ['tp5o']}, 10:32:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:16 INFO - 'talos_options': ['--disable-e10s', 10:32:16 INFO - '--xperf_path', 10:32:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:16 INFO - 'tests': ['tp5n']}, 10:32:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:16 INFO - 'talos_options': ['--xperf_path', 10:32:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:16 INFO - 'tests': ['tp5n']}}, 10:32:16 INFO - 'talos.zip': {'path': '', 10:32:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:32:16 INFO - Running post-action listener: _resource_record_post_action 10:32:16 INFO - [mozharness: 2016-10-17 17:32:16.986809Z] Finished populate-webroot step (success) 10:32:16 INFO - [mozharness: 2016-10-17 17:32:16.986901Z] Running create-virtualenv step. 10:32:16 INFO - Running pre-action listener: _resource_record_pre_action 10:32:16 INFO - Running main action method: create_virtualenv 10:32:16 INFO - Creating virtualenv /builds/slave/test/build/venv 10:32:16 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 10:32:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:32:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:32:17 INFO - Using real prefix '/usr' 10:32:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:32:17 INFO - Installing distribute.............................................................................................................................................................................................done. 10:32:19 INFO - Installing pip.................done. 10:32:19 INFO - Return code: 0 10:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:32:20 INFO - Reading from file tmpfile_stdout 10:32:20 INFO - Output received: 10:32:20 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) 10:32:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:32:20 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')]} 10:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:20 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')]} 10:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:20 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 0x7f087529cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12887b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', '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 10:32:20 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 10:32:20 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 10:32:20 INFO - Using env: {'DISPLAY': ':0', 10:32:20 INFO - 'HOME': '/home/cltbld', 10:32:20 INFO - 'LANG': 'en_US.UTF-8', 10:32:20 INFO - 'LANGUAGE': 'en_US:en', 10:32:20 INFO - 'LOGNAME': 'cltbld', 10:32:20 INFO - 'MAIL': '/var/mail/cltbld', 10:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:20 INFO - 'MOZ_NO_REMOTE': '1', 10:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:20 INFO - 'NO_EM_RESTART': '1', 10:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:20 INFO - 'PWD': '/builds/slave/test', 10:32:20 INFO - 'SHELL': '/bin/bash', 10:32:20 INFO - 'SHLVL': '1', 10:32:20 INFO - 'TERM': 'linux', 10:32:20 INFO - 'TMOUT': '86400', 10:32:20 INFO - 'USER': 'cltbld', 10:32:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:20 INFO - '_': '/tools/buildbot/bin/python'} 10:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:20 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 10:32:20 INFO - Cleaning up... 10:32:20 INFO - Return code: 0 10:32:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:32:20 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')]} 10:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:20 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')]} 10:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:20 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 0x7f087529cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12887b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', '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 10:32:20 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 10:32:20 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 10:32:20 INFO - Using env: {'DISPLAY': ':0', 10:32:20 INFO - 'HOME': '/home/cltbld', 10:32:20 INFO - 'LANG': 'en_US.UTF-8', 10:32:20 INFO - 'LANGUAGE': 'en_US:en', 10:32:20 INFO - 'LOGNAME': 'cltbld', 10:32:20 INFO - 'MAIL': '/var/mail/cltbld', 10:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:20 INFO - 'MOZ_NO_REMOTE': '1', 10:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:20 INFO - 'NO_EM_RESTART': '1', 10:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:20 INFO - 'PWD': '/builds/slave/test', 10:32:20 INFO - 'SHELL': '/bin/bash', 10:32:20 INFO - 'SHLVL': '1', 10:32:20 INFO - 'TERM': 'linux', 10:32:20 INFO - 'TMOUT': '86400', 10:32:20 INFO - 'USER': 'cltbld', 10:32:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:20 INFO - '_': '/tools/buildbot/bin/python'} 10:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:20 INFO - Downloading/unpacking psutil>=3.1.1 10:32: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 10:32: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 10:32: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 10:32: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 10:32: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 10:32: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 10:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:22 INFO - Installing collected packages: psutil 10:32:22 INFO - Running setup.py install for psutil 10:32:23 INFO - building 'psutil._psutil_linux' extension 10:32:23 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 10:32:24 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 10:32:24 INFO - building 'psutil._psutil_posix' extension 10:32:24 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 10:32:24 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 10:32:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:24 INFO - Successfully installed psutil 10:32:24 INFO - Cleaning up... 10:32:24 INFO - Return code: 0 10:32:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:32:24 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')]} 10:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:24 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')]} 10:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:24 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 0x7f087529cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12887b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', '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 10:32:24 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 10:32:24 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 10:32:24 INFO - Using env: {'DISPLAY': ':0', 10:32:24 INFO - 'HOME': '/home/cltbld', 10:32:24 INFO - 'LANG': 'en_US.UTF-8', 10:32:24 INFO - 'LANGUAGE': 'en_US:en', 10:32:24 INFO - 'LOGNAME': 'cltbld', 10:32:24 INFO - 'MAIL': '/var/mail/cltbld', 10:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:24 INFO - 'MOZ_NO_REMOTE': '1', 10:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:24 INFO - 'NO_EM_RESTART': '1', 10:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:24 INFO - 'PWD': '/builds/slave/test', 10:32:24 INFO - 'SHELL': '/bin/bash', 10:32:24 INFO - 'SHLVL': '1', 10:32:24 INFO - 'TERM': 'linux', 10:32:24 INFO - 'TMOUT': '86400', 10:32:24 INFO - 'USER': 'cltbld', 10:32:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:24 INFO - '_': '/tools/buildbot/bin/python'} 10:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:32:24 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 10:32:24 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 10:32:24 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 10:32:24 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 10:32:24 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 10:32:24 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 10:32:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:32:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:32:26 INFO - Installing collected packages: mozsystemmonitor 10:32:26 INFO - Running setup.py install for mozsystemmonitor 10:32:27 INFO - Successfully installed mozsystemmonitor 10:32:27 INFO - Cleaning up... 10:32:27 INFO - Return code: 0 10:32:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:32:27 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')]} 10:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:27 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')]} 10:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:27 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 0x7f087529cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12887b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', '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 10:32:27 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 10:32:27 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 10:32:27 INFO - Using env: {'DISPLAY': ':0', 10:32:27 INFO - 'HOME': '/home/cltbld', 10:32:27 INFO - 'LANG': 'en_US.UTF-8', 10:32:27 INFO - 'LANGUAGE': 'en_US:en', 10:32:27 INFO - 'LOGNAME': 'cltbld', 10:32:27 INFO - 'MAIL': '/var/mail/cltbld', 10:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:27 INFO - 'MOZ_NO_REMOTE': '1', 10:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:27 INFO - 'NO_EM_RESTART': '1', 10:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:27 INFO - 'PWD': '/builds/slave/test', 10:32:27 INFO - 'SHELL': '/bin/bash', 10:32:27 INFO - 'SHLVL': '1', 10:32:27 INFO - 'TERM': 'linux', 10:32:27 INFO - 'TMOUT': '86400', 10:32:27 INFO - 'USER': 'cltbld', 10:32:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:27 INFO - '_': '/tools/buildbot/bin/python'} 10:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:27 INFO - Downloading/unpacking jsonschema==2.5.1 10:32:27 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 10:32:27 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 10:32:27 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 10:32:27 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 10:32:27 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 10:32:27 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 10:32:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:32:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:29 INFO - Downloading functools32-3.2.3-2.tar.gz 10:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:32:29 INFO - warning: no files found matching '*.txt' 10:32:29 INFO - no previously-included directories found matching 'build' 10:32:29 INFO - no previously-included directories found matching 'dist' 10:32:29 INFO - no previously-included directories found matching '.git*' 10:32:29 INFO - Installing collected packages: jsonschema, functools32 10:32:29 INFO - Running setup.py install for functools32 10:32:29 INFO - warning: no files found matching '*.txt' 10:32:29 INFO - no previously-included directories found matching 'build' 10:32:29 INFO - no previously-included directories found matching 'dist' 10:32:29 INFO - no previously-included directories found matching '.git*' 10:32:29 INFO - Successfully installed jsonschema functools32 10:32:29 INFO - Cleaning up... 10:32:29 INFO - Return code: 0 10:32:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:32: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')]} 10:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32: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')]} 10:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32: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', '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 0x7f087529cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12887b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', '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 10:32: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:32: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 functools32==3.2.3-2 10:32:29 INFO - Using env: {'DISPLAY': ':0', 10:32:29 INFO - 'HOME': '/home/cltbld', 10:32:29 INFO - 'LANG': 'en_US.UTF-8', 10:32:29 INFO - 'LANGUAGE': 'en_US:en', 10:32:29 INFO - 'LOGNAME': 'cltbld', 10:32:29 INFO - 'MAIL': '/var/mail/cltbld', 10:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:29 INFO - 'MOZ_NO_REMOTE': '1', 10:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:29 INFO - 'NO_EM_RESTART': '1', 10:32:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:29 INFO - 'PWD': '/builds/slave/test', 10:32:29 INFO - 'SHELL': '/bin/bash', 10:32:29 INFO - 'SHLVL': '1', 10:32:29 INFO - 'TERM': 'linux', 10:32:29 INFO - 'TMOUT': '86400', 10:32:29 INFO - 'USER': 'cltbld', 10:32:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:29 INFO - '_': '/tools/buildbot/bin/python'} 10:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:32:29 INFO - Cleaning up... 10:32:29 INFO - Return code: 0 10:32:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:32: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')]} 10:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32: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')]} 10:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32: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', '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 0x7f087529cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12887b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', '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 10:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:32: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 blobuploader==1.2.4 10:32:29 INFO - Using env: {'DISPLAY': ':0', 10:32:29 INFO - 'HOME': '/home/cltbld', 10:32:29 INFO - 'LANG': 'en_US.UTF-8', 10:32:29 INFO - 'LANGUAGE': 'en_US:en', 10:32:29 INFO - 'LOGNAME': 'cltbld', 10:32:29 INFO - 'MAIL': '/var/mail/cltbld', 10:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:29 INFO - 'MOZ_NO_REMOTE': '1', 10:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:29 INFO - 'NO_EM_RESTART': '1', 10:32:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:29 INFO - 'PWD': '/builds/slave/test', 10:32:29 INFO - 'SHELL': '/bin/bash', 10:32:29 INFO - 'SHLVL': '1', 10:32:29 INFO - 'TERM': 'linux', 10:32:29 INFO - 'TMOUT': '86400', 10:32:29 INFO - 'USER': 'cltbld', 10:32:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:29 INFO - '_': '/tools/buildbot/bin/python'} 10:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:30 INFO - Downloading/unpacking blobuploader==1.2.4 10:32:30 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 10:32:30 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 10:32:30 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 10:32:30 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 10:32:30 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 10:32:30 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 10:32:32 INFO - Downloading blobuploader-1.2.4.tar.gz 10:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:32:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:32:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:32 INFO - Downloading docopt-0.6.1.tar.gz 10:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:32:32 INFO - Installing collected packages: blobuploader, requests, docopt 10:32:32 INFO - Running setup.py install for blobuploader 10:32:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:32:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:32:32 INFO - Running setup.py install for requests 10:32:33 INFO - Running setup.py install for docopt 10:32:33 INFO - Successfully installed blobuploader requests docopt 10:32:33 INFO - Cleaning up... 10:32:33 INFO - Return code: 0 10:32:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:33 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')]} 10:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:33 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')]} 10:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:33 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 0x7f087529cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12887b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', '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 10:32:33 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 10:32:33 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 10:32:33 INFO - Using env: {'DISPLAY': ':0', 10:32:33 INFO - 'HOME': '/home/cltbld', 10:32:33 INFO - 'LANG': 'en_US.UTF-8', 10:32:33 INFO - 'LANGUAGE': 'en_US:en', 10:32:33 INFO - 'LOGNAME': 'cltbld', 10:32:33 INFO - 'MAIL': '/var/mail/cltbld', 10:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:33 INFO - 'MOZ_NO_REMOTE': '1', 10:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:33 INFO - 'NO_EM_RESTART': '1', 10:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:33 INFO - 'PWD': '/builds/slave/test', 10:32:33 INFO - 'SHELL': '/bin/bash', 10:32:33 INFO - 'SHLVL': '1', 10:32:33 INFO - 'TERM': 'linux', 10:32:33 INFO - 'TMOUT': '86400', 10:32:33 INFO - 'USER': 'cltbld', 10:32:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:33 INFO - '_': '/tools/buildbot/bin/python'} 10:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:33 INFO - Running setup.py (path:/tmp/pip-m74ajo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:33 INFO - Running setup.py (path:/tmp/pip-BflHNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:33 INFO - Running setup.py (path:/tmp/pip-ydwHb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:33 INFO - Running setup.py (path:/tmp/pip-sXMEg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:34 INFO - Running setup.py (path:/tmp/pip-rNpFtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:34 INFO - Running setup.py (path:/tmp/pip-OzuPrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:34 INFO - Running setup.py (path:/tmp/pip-5gEys_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:34 INFO - Running setup.py (path:/tmp/pip-puNdqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:34 INFO - Running setup.py (path:/tmp/pip-SSMIjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:34 INFO - Running setup.py (path:/tmp/pip-GFPZ4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:34 INFO - Running setup.py (path:/tmp/pip-HnBq9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:34 INFO - Running setup.py (path:/tmp/pip-FdmN0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:34 INFO - Running setup.py (path:/tmp/pip-S05lkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:34 INFO - Running setup.py (path:/tmp/pip-7tSG4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:34 INFO - Running setup.py (path:/tmp/pip-qLuT5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:34 INFO - Running setup.py (path:/tmp/pip-XVkYtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:34 INFO - Running setup.py (path:/tmp/pip-6z9MN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:32:34 INFO - Running setup.py install for manifestparser 10:32:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for mozcrash 10:32:35 INFO - Running setup.py install for mozdebug 10:32:35 INFO - Running setup.py install for mozdevice 10:32:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for mozfile 10:32:35 INFO - Running setup.py install for mozhttpd 10:32:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for mozinfo 10:32:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for mozInstall 10:32:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for mozleak 10:32:35 INFO - Running setup.py install for mozlog 10:32:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for moznetwork 10:32:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Running setup.py install for mozprocess 10:32:36 INFO - Running setup.py install for mozprofile 10:32:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Running setup.py install for mozrunner 10:32:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Running setup.py install for mozscreenshot 10:32:36 INFO - Running setup.py install for moztest 10:32:36 INFO - Running setup.py install for mozversion 10:32:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:32:36 INFO - Cleaning up... 10:32:36 INFO - Return code: 0 10:32:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:36 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')]} 10:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:36 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')]} 10:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:36 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 0x7f087529cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12887b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', '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 10:32:36 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 10:32:36 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 10:32:36 INFO - Using env: {'DISPLAY': ':0', 10:32:36 INFO - 'HOME': '/home/cltbld', 10:32:36 INFO - 'LANG': 'en_US.UTF-8', 10:32:36 INFO - 'LANGUAGE': 'en_US:en', 10:32:36 INFO - 'LOGNAME': 'cltbld', 10:32:36 INFO - 'MAIL': '/var/mail/cltbld', 10:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:36 INFO - 'MOZ_NO_REMOTE': '1', 10:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:36 INFO - 'NO_EM_RESTART': '1', 10:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:36 INFO - 'PWD': '/builds/slave/test', 10:32:36 INFO - 'SHELL': '/bin/bash', 10:32:36 INFO - 'SHLVL': '1', 10:32:36 INFO - 'TERM': 'linux', 10:32:36 INFO - 'TMOUT': '86400', 10:32:36 INFO - 'USER': 'cltbld', 10:32:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:36 INFO - '_': '/tools/buildbot/bin/python'} 10:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:36 INFO - Running setup.py (path:/tmp/pip-yHRIcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:37 INFO - Running setup.py (path:/tmp/pip-dIbDzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:37 INFO - Running setup.py (path:/tmp/pip-6zBp0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:37 INFO - Running setup.py (path:/tmp/pip-V94K5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:37 INFO - Running setup.py (path:/tmp/pip-kuWA7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:37 INFO - Running setup.py (path:/tmp/pip-uXPtFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:37 INFO - Running setup.py (path:/tmp/pip-Q_PBgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:37 INFO - Running setup.py (path:/tmp/pip-cyIxx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:37 INFO - Running setup.py (path:/tmp/pip-j9Z7g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:37 INFO - Running setup.py (path:/tmp/pip-CP2j2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:37 INFO - Running setup.py (path:/tmp/pip-cUsDZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:37 INFO - Running setup.py (path:/tmp/pip-JYaEFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:37 INFO - Running setup.py (path:/tmp/pip-V4oIc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:37 INFO - Running setup.py (path:/tmp/pip-_recoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:38 INFO - Running setup.py (path:/tmp/pip-jEdPwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:38 INFO - Running setup.py (path:/tmp/pip-IpAqeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:38 INFO - Running setup.py (path:/tmp/pip-BnwZAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:38 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)) 10:32:38 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)) 10:32:38 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)) 10:32:38 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)) 10:32:38 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)) 10:32:38 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)) 10:32:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:32:38 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 10:32:38 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 10:32:38 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 10:32:38 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 10:32:38 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 10:32:38 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 10:32:40 INFO - Downloading blessings-1.6.tar.gz 10:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:32:40 INFO - Installing collected packages: blessings 10:32:40 INFO - Running setup.py install for blessings 10:32:40 INFO - Successfully installed blessings 10:32:40 INFO - Cleaning up... 10:32:40 INFO - Return code: 0 10:32:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:40 INFO - Reading from file tmpfile_stdout 10:32:40 INFO - Current package versions: 10:32:40 INFO - argparse == 1.2.1 10:32:40 INFO - blessings == 1.6 10:32:40 INFO - blobuploader == 1.2.4 10:32:40 INFO - docopt == 0.6.1 10:32:40 INFO - functools32 == 3.2.3-2 10:32:40 INFO - jsonschema == 2.5.1 10:32:40 INFO - manifestparser == 1.1 10:32:40 INFO - mozInstall == 1.12 10:32:40 INFO - mozcrash == 0.17 10:32:40 INFO - mozdebug == 0.1 10:32:40 INFO - mozdevice == 0.48 10:32:40 INFO - mozfile == 1.2 10:32:40 INFO - mozhttpd == 0.7 10:32:40 INFO - mozinfo == 0.9 10:32:40 INFO - mozleak == 0.1 10:32:40 INFO - mozlog == 3.4 10:32:40 INFO - moznetwork == 0.27 10:32:40 INFO - mozprocess == 0.23 10:32:40 INFO - mozprofile == 0.28 10:32:40 INFO - mozrunner == 6.12 10:32:40 INFO - mozscreenshot == 0.1 10:32:40 INFO - mozsystemmonitor == 0.3 10:32:40 INFO - moztest == 0.7 10:32:40 INFO - mozversion == 1.4 10:32:40 INFO - psutil == 3.1.1 10:32:40 INFO - requests == 1.2.3 10:32:40 INFO - wsgiref == 0.1.2 10:32:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:40 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')]} 10:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:40 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')]} 10:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:40 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 0x7f087529cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12887b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', '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 10:32:40 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 10:32:40 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 10:32:40 INFO - Using env: {'DISPLAY': ':0', 10:32:40 INFO - 'HOME': '/home/cltbld', 10:32:40 INFO - 'LANG': 'en_US.UTF-8', 10:32:40 INFO - 'LANGUAGE': 'en_US:en', 10:32:40 INFO - 'LOGNAME': 'cltbld', 10:32:40 INFO - 'MAIL': '/var/mail/cltbld', 10:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:40 INFO - 'MOZ_NO_REMOTE': '1', 10:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:40 INFO - 'NO_EM_RESTART': '1', 10:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:40 INFO - 'PWD': '/builds/slave/test', 10:32:40 INFO - 'SHELL': '/bin/bash', 10:32:40 INFO - 'SHLVL': '1', 10:32:40 INFO - 'TERM': 'linux', 10:32:40 INFO - 'TMOUT': '86400', 10:32:40 INFO - 'USER': 'cltbld', 10:32:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:40 INFO - '_': '/tools/buildbot/bin/python'} 10:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:41 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)) 10:32:41 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)) 10:32:41 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)) 10:32:41 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)) 10:32:41 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)) 10:32:41 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)) 10:32:41 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)) 10:32:41 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)) 10:32:41 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)) 10:32:41 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)) 10:32:41 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)) 10:32:41 INFO - Cleaning up... 10:32:41 INFO - Return code: 0 10:32:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:32:41 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')]} 10:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:41 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')]} 10:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:41 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 0x7f087529cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12887b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', '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 10:32:41 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 10:32:41 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 10:32:41 INFO - Using env: {'DISPLAY': ':0', 10:32:41 INFO - 'HOME': '/home/cltbld', 10:32:41 INFO - 'LANG': 'en_US.UTF-8', 10:32:41 INFO - 'LANGUAGE': 'en_US:en', 10:32:41 INFO - 'LOGNAME': 'cltbld', 10:32:41 INFO - 'MAIL': '/var/mail/cltbld', 10:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:41 INFO - 'MOZ_NO_REMOTE': '1', 10:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:41 INFO - 'NO_EM_RESTART': '1', 10:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:41 INFO - 'PWD': '/builds/slave/test', 10:32:41 INFO - 'SHELL': '/bin/bash', 10:32:41 INFO - 'SHLVL': '1', 10:32:41 INFO - 'TERM': 'linux', 10:32:41 INFO - 'TMOUT': '86400', 10:32:41 INFO - 'USER': 'cltbld', 10:32:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:41 INFO - '_': '/tools/buildbot/bin/python'} 10:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:32:41 INFO - Cleaning up... 10:32:41 INFO - Return code: 0 10:32:41 INFO - Running post-action listener: _resource_record_post_action 10:32:41 INFO - Running post-action listener: _start_resource_monitoring 10:32:41 INFO - Starting resource monitoring. 10:32:41 INFO - [mozharness: 2016-10-17 17:32:41.385956Z] Finished create-virtualenv step (success) 10:32:41 INFO - [mozharness: 2016-10-17 17:32:41.387003Z] Running install step. 10:32:41 INFO - Running pre-action listener: _resource_record_pre_action 10:32:41 INFO - Running main action method: install 10:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:41 INFO - Reading from file tmpfile_stdout 10:32:41 INFO - Detecting whether we're running mozinstall >=1.0... 10:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:32:41 INFO - Reading from file tmpfile_stdout 10:32:41 INFO - Output received: 10:32:41 INFO - Usage: mozinstall [options] installer 10:32:41 INFO - Options: 10:32:41 INFO - -h, --help show this help message and exit 10:32:41 INFO - -d DEST, --destination=DEST 10:32:41 INFO - Directory to install application into. [default: 10:32:41 INFO - "/builds/slave/test"] 10:32:41 INFO - --app=APP Application being installed. [default: firefox] 10:32:41 INFO - mkdir: /builds/slave/test/build/application 10:32:41 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'] 10:32:41 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 10:32:58 INFO - Reading from file tmpfile_stdout 10:32:58 INFO - Output received: 10:32:58 INFO - /builds/slave/test/build/application/firefox/firefox 10:32:58 INFO - Running post-action listener: _resource_record_post_action 10:32:58 INFO - [mozharness: 2016-10-17 17:32:58.638437Z] Finished install step (success) 10:32:58 INFO - [mozharness: 2016-10-17 17:32:58.638754Z] Running run-tests step. 10:32:58 INFO - Running pre-action listener: _resource_record_pre_action 10:32:58 INFO - Running main action method: run_tests 10:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:32:58 INFO - Python 2.7.3 10:32:58 INFO - Return code: 0 10:32:58 INFO - grabbing minidump binary from tooltool 10:32:58 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')]} 10:32:58 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 0x1317790>, '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 0x1318690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1318b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:32:58 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 10:32:58 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 10:32:58 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 10:32:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:32:58 INFO - Return code: 0 10:32:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:32:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:32:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:32:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:32:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 10:32:58 INFO - Using env: {'DISPLAY': ':0', 10:32:58 INFO - 'HOME': '/home/cltbld', 10:32:58 INFO - 'LANG': 'en_US.UTF-8', 10:32:58 INFO - 'LANGUAGE': 'en_US:en', 10:32:58 INFO - 'LOGNAME': 'cltbld', 10:32:58 INFO - 'MAIL': '/var/mail/cltbld', 10:32:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:32:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:58 INFO - 'MOZ_NO_REMOTE': '1', 10:32:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:32:58 INFO - 'NO_EM_RESTART': '1', 10:32:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:58 INFO - 'PWD': '/builds/slave/test', 10:32:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:32:58 INFO - 'SHELL': '/bin/bash', 10:32:58 INFO - 'SHLVL': '1', 10:32:58 INFO - 'TERM': 'linux', 10:32:58 INFO - 'TMOUT': '86400', 10:32:58 INFO - 'USER': 'cltbld', 10:32:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830', 10:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:58 INFO - '_': '/tools/buildbot/bin/python'} 10:32:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:32:59 INFO - mozversion application_buildid: 20161017073002 10:32:59 INFO - mozversion application_changeset: 7c8216f48c38a8498f251fe044509b930af44de6 10:32:59 INFO - mozversion application_display_name: Nightly 10:32:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:32:59 INFO - mozversion application_name: Firefox 10:32:59 INFO - mozversion application_remotingname: firefox 10:32:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:32:59 INFO - mozversion application_vendor: Mozilla 10:32:59 INFO - mozversion application_version: 52.0a1 10:32:59 INFO - mozversion platform_buildid: 20161017073002 10:32:59 INFO - mozversion platform_changeset: 7c8216f48c38a8498f251fe044509b930af44de6 10:32:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:32:59 INFO - mozversion platform_version: 52.0a1 10:32:59 INFO - using testdate: 1476725579 10:32:59 INFO - actual date: 1476725579 10:32:59 INFO - starting webserver on 'localhost:38513' 10:32:59 INFO - SUITE-START | Running 2 tests 10:32:59 INFO - TEST-START | dromaeo_css 10:32:59 INFO - operating with platform_type : linux_ 10:32:59 INFO - Initialising browser for dromaeo_css test... 10:32:59 INFO - TEST-INFO | started process 3330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9CAxgX/profile http://localhost:38513/getInfo.html) 10:33:05 INFO - PROCESS | 3330 | __metrics Screen width/height:1600/1200 10:33:05 INFO - PROCESS | 3330 | colorDepth:24 10:33:05 INFO - PROCESS | 3330 | Browser inner width/height: 1024/697 10:33:05 INFO - PROCESS | 3330 | __metrics 10:33:07 INFO - PROCESS | 3330 | 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" 10:33:07 INFO - PROCESS | 3330 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:33:08 INFO - PROCESS | 3330 | console.error: PushService: 10:33:08 INFO - PROCESS | 3330 | stateChangeProcessEnqueue: Error transitioning state 10:33:08 INFO - PROCESS | 3330 | UnknownError 10:33:08 INFO - TEST-INFO | 3330: exit 0 10:33:08 INFO - Browser initialized. 10:33:08 INFO - Running cycle 1/1 for dromaeo_css test... 10:33:08 INFO - TEST-INFO | started process 3416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9CAxgX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:20 INFO - PROCESS | 3416 | RSS: Main: 171728896 10:33:20 INFO - PROCESS | 3416 | 10:34:12 INFO - PROCESS | 3416 | 1476725652405 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] 10:36:24 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38513/tests/dromaeo/cssquery-ext.html) 10:36:25 INFO - PROCESS | 3416 | RSS: Main: 287686656 10:36:25 INFO - PROCESS | 3416 | 10:39:28 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-ext.html (next: http://localhost:38513/tests/dromaeo/cssquery-jquery.html) 10:39:28 INFO - PROCESS | 3416 | RSS: Main: 282185728 10:39:28 INFO - PROCESS | 3416 | 10:42:30 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38513/tests/dromaeo/cssquery-mootools.html) 10:42:31 INFO - PROCESS | 3416 | RSS: Main: 213508096 10:42:31 INFO - PROCESS | 3416 | 10:45:33 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38513/tests/dromaeo/cssquery-prototype.html) 10:45:33 INFO - PROCESS | 3416 | RSS: Main: 246505472 10:45:33 INFO - PROCESS | 3416 | 10:48:36 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38513/tests/dromaeo/cssquery-yui.html) 10:48:37 INFO - PROCESS | 3416 | RSS: Main: 213942272 10:48:37 INFO - PROCESS | 3416 | 10:51:40 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-yui.html (next: http://localhost:38513/tests/dromaeo/cssquery-dojo.html) 10:51:40 INFO - PROCESS | 3416 | RSS: Main: 301113344 10:51:40 INFO - PROCESS | 3416 | 10:51:40 INFO - PROCESS | 3416 | __start_tp_report 10:51:40 INFO - PROCESS | 3416 | _x_x_mozilla_page_load 10:51:40 INFO - PROCESS | 3416 | _x_x_mozilla_page_load_details 10:51:40 INFO - PROCESS | 3416 | |i|pagename|runs| 10:51:40 INFO - PROCESS | 3416 | |0;dojo.html;2878.899238526652;2949.2331993681637;2950.8377039262837;2956.911292661221;2990.117915215011;5195.19474481456;5268.209768534722;5294.682319060854;5410.404855465896;5506.284183056202;5296.3379577552805;5329.467053294668;5387.057264978623;5425.294711687475;5446.183072539121;4839.806407743704;4872.683275587093;4913.680610760307;4919.631027672921;4975.776090075937;4866.245731911559;4971.502849715036;5030.949690503085;5042.798288068473;5070.492950704936;4724.5039270876405;4763.523647635244;4823.758812059418;4898.118338699051;4903.852884413455;4793.49668284832;4803.279508073782;4816.555033489974;4857.222844344923;4920.507949205086;4774.832880849153;4803.327534145223;4816.61467082636;4819.590334821544;4876.146674331978;5302.628815982883;5322.281491998569;5325.840224793263;5326.147816349366;5347.759350829222;5507.091329930557;5537.667739935577;5716.8856622867725;5761.3950535194035;5792.623479473821;5888.5289176865745;5904;5904.232449781543;5957.970210148921;5977.521798256129;5469.835904922819;5488.725563721798;5489.533389661844;5489.533389661844;5489.58828087895;5651.519620832275;5654.236678048493;5708.429157084258;5997.400259973968;6003.759849605967;5514.558835293167;5519.254900588369;5521.033819081645;5527.115661494142;5555.638883472561;5568.832935011957;5573.247611572386;5582.91625625616;5583.218349431083;5584.106542953189;5570.470805273492;5591;5591.832245032656;5592.944070559242;5594.440555944454;5595.664260144405;5596.608237423341;5599.692016939108;5601.271834661468;5605.271314729059;4337.436133302651;4357.128574285092;4358.171947329997;4358.346248062816;4359.455068116486;3864.8260828262796;3884.067823722343;3905.1799122184093;3905.8437662493184;3908.726389152732;5453.182022696627;5453.836384908459;5454.563634909197;5462.781488740406;5532.30846144232;5563.527100196528;5618.943810561842;5777.306723193244;5780.306363236438;5790.768369265183;5367.946320536745;5410.1343784994215;5422.295101636841;5454.781808727606;5455.208994695826;4986.90026199474;4988.975055124701;5004.3494345734825;5017.523335283142;5070.112730272188;5785.074388097884;5840.8247752567495;5841.386654401226;5994.250718660168;6002.069679199731;5725.713714314351;5797.362290147996;5804.303483581997;5874.676892770939;5885.970570147122;5961.344252132349;5962.970185149046;5966.3138739043825;5976.701164941648;6042.093685947143;5676.17695434168;5676.893005863817;5680.318361796611;5680.545556355564;5681.744321505625;5526.50261476469;5541.806036788693;5697.487226149667;5702.372738998624;5727.255456790591;5633.4366563344975;5634.2393776841245;5635.971820140873;5636.4927156556105;5692.743826527733;5544.390117087198;5562.082256427806;5619.185218143264;5619.943800561942;5623;5255.185446255837;5387.407385187548;5529.778808847601;5595.35653399848;5608.186812912187;5721.256236689203;5724.398938111438;5724.656520608777;5749.223854779551;5787.479126878601;5566.081596536526;5576.749046293007;5582.162675598693;5582.441755824385;5631.549476041989 10:51:40 INFO - PROCESS | 3416 | |1;ext.html;547.9603188467092;571.2830397850698;598.6617561077991;616.11587372121;622.073111064514;32223.51664725031;32979;35382.46926296107;35388.469172962425;35429.82285088574;34961.32906044867;44518;45382.319265211045;45449.54550454503;48956.2656560151;8692.174243446863;8819.382643214978;8826.382153249275;8829.16122968317;8829.602667879928;8636.093210212932;8736.650533978665;8741.606627701736;8742.169493898102;8752.037275899645;8011.158828323;8196.3033142183;8198.221168988937;10344.120749736281;10584.047435730783;10638.893611063906;10702;10707.732306692316;10708.25042247043;10711.303765255312;10452.477376131163;10541.262111652188;10543.156547476183;10546.209034322379;10548.683539493828;42082.368764468556;42408.36387454191;42413.15173696509;42435.36346954767;42444;3293.637699853014;3376.5104059911178;3405.3700065487715;3456.723462123049;3517.3317069756663;31236;32156.678433215602;32259.83870080658;32284.515732264033;32300.838495807606;4180.561041090703;4327.221100201962;4342.435483387139;4367.3448982652535;4537.160625284333;324378;324986;325273;326157.9999999976;326323;58267.70866145642;58461;58580.4141958575;58625;58652.4134758647;61412;61434.38565614376;61516.38483615107;61518;61626.69186654038;14620.049696769676;14835.18406487632;14842.628934276729;14845.777313340308;14845.851541484662;10862.293950893167;10863.83704244437;10866.67399978002;10868.45657717111;10870.782584348268;13088.672137825555;17123.400680976105;17181.656366872594;17198.570035748955;17396.085880676746;5053.216751403538;5748.971255143698;5821.768918250412;5881.441263080001;5883.94116058834;904.2133343990639;963.2486660404755;1018.8420794776821;1027.6557353286582;1041.8489319048695;31433;31488.527672084936;31534.36931261408;32158.35683286321;32488.675113248566;1133.21241736992;1149.672343382132;1155.1625071822862;1157.3634501024403;1159.368144361325;16349.918250408671;16696.41562545305;16702.83297167037;16895.915520422564;17136.22886970089;473579;477047;478671;478984;481407;58116.70941645265;58279;58342;58407.70796146077;58427.70786146042;1181.2026881854713;1234.5432190089725;1257.9433925473375;1264.3362234826973;1311.8556958734532;29069;32681.34637307193;32804.507932380555;32881;33679.32641347208;50417.74791126021;50940.49059509357;50952.49047509626;50976.235356470424;51007;352258;352968;353632;353892;355291;40271.79864100661;40643;41494.71779052181;41583.1683366337;41603;46909;47630.52369476261;47725;47734;48230.517694824004;39130.109260433695;39521.60478395179;40468.392974106;40533;42081.57918420777;39878.60121398749;40501.594984050964;40535.594644053184;41113.79443102765;42160.1567968645;40015;40445.59554404418;40743.1851362977;41101;41248.79375603103;33917.49123763195;36065.5573777046;36581.63418365889;36999.63000369962;37029.25941481209;27283.31791705223;27717.861410692818;27796.86101569479;27798.305042374104;27809 10:51:40 INFO - PROCESS | 3416 | |2;jquery.html;374.55802153458944;380.61177598849173;399.7082130045067;400.4933758795125;419.61185903039683;13210.141340812852;15298.388064477422;16288.674226515477;19279.710804337945;19386.22455101798;19028;19129.42611721647;19223.519412014706;19421.514462138417;19557.80442195581;5477.178423236526;5529.668219906818;5727.169560413738;5729.541636669077;5738.368779434259;4519.389882365871;5664.773409063632;5690.516306113986;5694.316681998166;5695.629784064023;5418.512333889949;5657.745401456944;5659.490645841874;5659.915101273484;5666.51834594058;5602.1036634138345;5641.294838145232;5642.520385767194;5648.181013752983;5679.829605111832;4822.469528351879;5053.862880851816;5061.038402703512;5061.746912654353;5090.490950904917;22957.426064348358;22988.65517017246;23032.53934921309;23099.53800923989;23251.7674823253;2256.8420210585264;2518.2319392585255;2934.4571254317807;2959.970400295991;2989.744307390901;13639.195243624745;14637.926810365987;14657.706845863024;14730.779038314435;14883.70232595342;1917.7411049508278;1942.7960064193198;1950.804919508052;2019.1216820682903;2077.574097310048;80560.59719701423;81211;81705.59147204286;81756.59121704413;81760.59119704422;10058.899411005943;10324.43215623148;10431.478426078666;10529.157667386591;10929.071028962628;14594.737815638593;14630.853691463162;14636.04865683727;14639.634009149644;14668.339924703414;6568.7372505099265;6836.794896153124;6882.69027893746;7091.964540177266;7113.395361394236;6138.263408391022;6190.876182476415;6275.654838983808;6324.841878952971;6369.7452101915405;6404.167458230493;6411.551191416649;6426.485881129498;6457.2896981332015;6606.702698378488;1861.692820684599;1881.6330815490849;1931;1931.4750580191208;1936.2203821592534;958.0205560706198;968.5496244246459;1002.5638847101534;1025.487256371814;1043.3739756146251;19362.515937101405;19755.802441975684;19866.70199947002;19919.60160796776;20243;991.3853410885297;994.8855881573712;1056.445366182745;1056.8784589772274;1106.5573770491867;10344.948275258575;10404;11261.514294378165;11334.129868571594;11500.309981401142;434287;450614;461381;473350.9445645693;482048;96868.51565742126;98173;98538;101378;103367.48316258371;994.9005099489993;1061.6708820265742;1066.5840322274319;1068.0921216965517;1078.0890147825075;16894.831051689816;16902.83097169062;17490.764208621447;17890.463286101436;18169.454916352002;38452.230955380175;43670;43934.56065439305;43935;44790.77604611956;46876;55433.44566554283;56825.715871420376;57721.711391442775;57975;8392.244697977212;8398.874016889873;8459.661613535389;8665.43674661145;8861.64553417856;12635.684107897376;13086.541971030969;13246.337683115999;13495.122817016863;13627;11445.25605835618;11469.369184694922;11841.940790295994;12086.214396064228;12436.689082773004;10975.615853445091;11008.009279164593;11054.170937179582;11302.830457543309;11910.166288359731;11478.598249061242;11513;11530.077593792308;11573.511694985618;11904.642860714192;7588.696452141852;7837.568933708701;8251.2986396157;8824.117588241124;8851.645934162561;11260.774784504429;11644;11955.880441195477;12089.39553022363;12676.619701408972 10:51:40 INFO - PROCESS | 3416 | |3;mootools.html;1326.045247421856;1426.0944300369265;1486.0563542150733;1606.333371650765;1791.9104044797748;7877.960610196948;8472.195141461567;8756.737297881058;8772.078931712158;9026.36815422919;8824.294056475483;8882.333824963122;8900.866487002684;8910.108989101087;8918.331125165607;2310.1106074161403;2326.4300246439648;2328.52265285616;2331.067572970817;2338.0764597983784;2242.5627002734473;2289.4848659051745;2316.143027079974;2318.8144948404088;2329.2546385156757;2238.88055972014;2258.9435264118447;2272.874991875446;2292.9770702293013;2300.9884950575224;2188.2559929624003;2196.5716685246384;2218.267971569386;2227.66585012247;2231.7656646052174;2213.1368766181204;2266.46738016566;2266.5353602511445;2273.283915566608;2276.06681260684;8985.37102402832;9062.501562414065;9124.635014599407;9132.634694612207;9171.128742769426;5424.321959755031;5552.11166213408;5559;5561.443855614447;5569.443055694439;3536.2043540203504;3563.4120370138894;3599.4780756790383;3621.5473065866768;3626.601073881871;1145.6792098212513;1146.7821113988316;1150.4362862197463;1163.2264544078178;1172.724409763705;12479.19051737493;12519.874801251963;12569.622911312676;12576.056795740356;12577.308248046354;4469.217886869785;4623.329617205486;4748.074125545486;4776.546228108394;4812.590929770939;9978.151857092083;10011.099001089791;10113.949430252802;10122.291439599157;10125.240606954509;5383.865403364869;5422.620416570802;5434.049041417736;5436.70098144598;5437.8368648940595;4225;4306.375575541529;4435.068635586563;4993.775280112403;5088.313077734532;3682.1346983458866;3776.66010059096;3794.032521706947;3842.442845787401;3895.6493915547735;1162.511745067074;1170.7190274334098;1179.2099293473393;1189.5063548627395;1191.2614179208947;928.8281667891462;935.0182308575968;942.990570094304;958.3483231402573;979.5591983607405;5687.260656114761;5713.171590119409;5759.2512973313205;5817.883642327214;6190.226221722285;435.0776354129266;436.6594056635829;442.16872280113824;444.0785370356523;451.61612629264863;3843.2121415109837;3971.0866500705;4011.358182690814;4032.2943484890616;4117.794110294473;11287.153463490271;11469.88530114705;11549.13381496391;11550.902664246883;11697.415129243504;11417.771644567061;11444.14168937333;11453.14101442395;11454.427278636034;11460.02589779878;8044.517328960164;8054.436189466798;8129.227723366271;8174.550399728072;8183.263506284582;5700.543956483554;5704.914426283526;5745.885082298414;5759.971200143972;5915.940840591539;10312.896871031193;10420.426876521864;10454.738631533968;10468.94765526198;10643.94678026605;9918.40489570628;10330.121939635215;10336.17310615134;10613.893861061291;10660.946695266473;7052.717891284291;7160.856782864418;7221.097362829646;7749.651265692944;7921.287084162453;8109.75670729879;8167.714130005421;8369.163083691583;8473.95763021181;8553.144685531397;7796.103448103314;7914.564698941614;8054.556999364857;8059.274665280153;8147.877781833158;7631.771046868603;7696.769096927102;7776.066871975399;7780.377569794516;7822.843543128992;6810.421114205348;6910.205326387329;6915;6921.1002569665625;6924.861502770017;4828.324034635084;4846.5153484652665;4866.8053277868485;4980;5054.342935418372;4862.857228551358;4954.65317427791;5051.823186188466;5077.162268225849;5148.871278218075 10:51:40 INFO - PROCESS | 3416 | |4;prototype.html;326.2577635878377;326.26101879243504;334.64527600743213;336.10595815131745;340.73763202334186;5063.696178229309;5169.715665638389;5210.270562121302;5248.343957005374;5249.71126588038;5027.673201241917;5080.618953578487;5096.311997880285;5117.257997590347;5199.610029247812;4082.632563069323;4090.5887468823207;4112.321466957948;4120.299549076664;4127.422160897462;3960.9007226170033;4065.6544193743566;4110.958890411102;4132.318167502373;4152.958470415288;4046.6358027777496;4061.208064427438;4071.857484988026;4088.10061786408;4092.877213683594;4060.8984775380554;4062.659322423593;4063.79681015948;4065.1869626074904;4085.673146148316;3637.163452405935;3646.0520264731094;3648.361536731088;3652.1600031992525;3667.541557305337;4861.805527778884;5047.722375269359;5050.469700681412;5075.111855425286;5090.796368145269;4596.770161491912;4598.563136502027;4609.916669582645;4637.489876113625;4642.303654451825;5375.731213439312;5394;5396.10964190908;5409.215663728776;5413.512783849473;3663.9267214655824;3829.349010668193;3847.3267178243696;3912.2371137628174;3913.784741839226;5571.470710282517;5617.325920889479;5622.859428514279;5646.802361917313;5657.688827114466;4005.2189822984237;4005.5794141615293;4013.6387725104296;4014.1770936957855;4017.879463616038;3952.2293152835496;4009.1781184857036;4052.371882358239;4057.2899742544937;4066.898327541835;4582.762654083379;4592.357070010201;4599;4603.930941035887;4609.7695115244105;5383.78464861409;5414.3502779665905;5418.322709661293;5419.972900135474;5444.891102177934;1283.7560863435917;1297.2605614799663;1330.4279159961116;1331.4274861809322;1378.1386633354155;879.3624622148891;897.9506127162938;905.8595917632778;906.4833045164193;912.6075787411344;4613.377194078824;4627.699199552018;4635.675502714845;4639.304104384302;4663;4888.633352498577;4918.311436398907;4918.311436398907;5233.581313494911;5646.322441307069;5250.422453530108;5256.684598924076;5265.631405801557;5273.393559740679;5329.333833270841;2913.3393965439495;2944.2344990302677;2956.926076848096;2963.5110206816066;2963.5702823090533;5489.533389661844;5717.256236847718;5757.971210144006;5764.913526297109;5775.653460792366;5627.606067575312;5645.887082258332;5664.716764161775;5674.432556744293;5677.290338707661;5486.259354987025;5748.396418376094;5753.59724819267;5799.391063938226;5817.3019237690905;5527.281453411031;5532.889342213214;5535.280413546374;5546.278983732089;5554.75003624846;5500.9174862377895;5507.807226747205;5508.5402368371615;5534.667919924656;5563.721813909369;5411.511834245614;5667.773289068391;5687;5805.506531944832;5809.76760929575;3967.2263908537557;3973.145773658677;4008.579099194543;4036.0515278908847;4040.7777572232635;5613.382527922007;5615.382307946041;5644.915326270191;5649.514213745939;5652.152177173457;5270.762815673227;5410.567154627542;5436.55931178246;5456.7544460498575;5505.642133261325;5369.597280204079;5377.435369286169;5385.299911011543;5386.272853164773;5420.186971954238;5183.885464625124;5286.497782710637;5299.602529810202;5305.763484274512;5315.202719592092;5085.516875896784;5402;5446.918296225481;5450.209719590716;5484.369297530835;5231.267622532772;5329.866753331198;5333.7333133343955;5335.493128152819;5346.304980352529 10:51:40 INFO - PROCESS | 3416 | |5;yui.html;723.8805597076486;729.325374029023;753.0232396843245;762.2073044034205;872.9432586881852;14897.627559311022;14970;15035.09789412636;15617.984830985977;16638.916805415985;15152.924235378836;15752.369905203777;15840.76238856418;15880.126593037377;15906.204689765495;798.1061211443192;824.4270232188601;826.5495305058728;826.9007719073719;826.9751907442786;673.9595624262536;690.4579904774753;793.2345286798238;803.1927912447982;804.9114597394282;862.8101817600118;865.6840253307561;866.6446756829702;866.7876370289288;866.9176428239307;856.3235044314983;856.7130011446174;856.9871451928195;857.6140736668524;857.6655104509247;514.6114683413998;522.9555487783543;614.9815505534841;620.5625034350771;629.6914511889187;15164.469243576423;15247.23763811816;15266.3130159142;15304.617384565476;15308.846911530853;13891;14200.431982720678;14567.344469498898;14589.562313130624;14613;13059.869401306056;13219;13246.602601921957;13405.66485837852;14140.151590904476;4409.955900440987;4436.511983681792;4449.71076880005;4451.332300154971;4513;77148.61425692835;77344.61327693381;79575.60212198959;80054.19945800584;80558;10276.229282803819;11233;11326;11441.427928603536;11874.1094417919;20813.58372832535;20845.58308833815;20852.791472085388;20854.165833366496;20868.582628347347;7905.841883162305;8048.476849004796;8072.313853322534;8223.835523289501;8286.295664868554;4488.977555112204;4611.377464042378;4659.184642687516;4670.719756814602;4781.187198176319;3309.3546758381885;3388.0513456232293;3418.4872269159328;3425.828708564562;3428.160100775326;599.5713065158345;607.7389416959826;610.6732897899602;619.0590302739811;636.8694417644465;654.6955665615417;661.4741280681869;671.5701950751522;691.1222747111141;695.8817001109824;9301.953490232505;9381;9423.246140308896;9424.811503769886;9447.905520944703;691.3155975584236;698.8742026435189;709.8899670551073;727.2908913808994;746.5334166146158;3652.6712595866497;3986.681065514752;4429.2027435062;4443.488998765119;4461.754603496839;76651.61674191593;84987.15012849915;125242.39384821123;126411;127420.36289818492;104381.47809260905;105071.47464262783;105720.47139764253;106708;109400;74549.62725186339;91468.54265728629;91599;91604.54197729102;92211.53894230486;8856.911430885608;8942.418742781958;9023.548822558978;9143.908560914571;9152.084791520794;52958.73520632372;53266.46733532615;53269.46730532645;54254.13315069214;54811.45188548064;73530.63234683793;76424;80273.5986320088;80870.59564702139;82807;11529.289684004883;11551.107507573259;11631.069514438994;11647.359395233343;12070.939645301718;13047.673808154872;13082.149660272053;13111.344432778515;13135.343232838512;13814.102083364549;11902.226355286879;12198.939005304917;12200.267983920992;12475.438605262967;13153.120013520955;10831.51258193399;13574.457021719021;13682.657933551742;13767.586972390844;13984.790228146383;13788.379522921292;13880.861191387958;13998.230097344744;14169.504067357593;14538.273086345429;10725;10743.301685390425;10863.348199108079;11057.889421105687;12526.123171377916;11494.655160345203;11649.34026389451;11704.239224450383;11810.468528916048;12054.457549410123 10:51:40 INFO - PROCESS | 3416 | __end_tp_report 10:51:40 INFO - PROCESS | 3416 | __start_cc_report 10:51:40 INFO - PROCESS | 3416 | _x_x_mozilla_cycle_collect,1040 10:51:40 INFO - PROCESS | 3416 | __end_cc_report 10:51:40 INFO - PROCESS | 3416 | __startTimestamp1476726700386__endTimestamp 10:51:40 INFO - PROCESS | 3416 | 10:51:40 INFO - PROCESS | 3416 | ------- Summary: start ------- 10:51:40 INFO - PROCESS | 3416 | Number of tests: 6 10:51:40 INFO - PROCESS | 3416 | 10:51:40 INFO - PROCESS | 3416 | [#0] dojo.html Cycles:165 Average:5316.66 Median:5529.78 stddev:622.95 (11.3%) stddev-sans-first:594.78 10:51:40 INFO - PROCESS | 3416 | Values: 2878.9 2949.2 2950.8 2956.9 2990.1 5195.2 5268.2 5294.7 5410.4 5506.3 5296.3 5329.5 5387.1 5425.3 5446.2 4839.8 4872.7 4913.7 4919.6 4975.8 4866.2 4971.5 5030.9 5042.8 5070.5 4724.5 4763.5 4823.8 4898.1 4903.9 4793.5 4803.3 4816.6 4857.2 4920.5 4774.8 4803.3 4816.6 4819.6 4876.1 5302.6 5322.3 5325.8 5326.1 5347.8 5507.1 5537.7 5716.9 5761.4 5792.6 5888.5 5904.0 5904.2 5958.0 5977.5 5469.8 5488.7 5489.5 5489.5 5489.6 5651.5 5654.2 5708.4 5997.4 6003.8 5514.6 5519.3 5521.0 5527.1 5555.6 5568.8 5573.2 5582.9 5583.2 5584.1 5570.5 5591.0 5591.8 5592.9 5594.4 5595.7 5596.6 5599.7 5601.3 5605.3 4337.4 4357.1 4358.2 4358.3 4359.5 3864.8 3884.1 3905.2 3905.8 3908.7 5453.2 5453.8 5454.6 5462.8 5532.3 5563.5 5618.9 5777.3 5780.3 5790.8 5367.9 5410.1 5422.3 5454.8 5455.2 4986.9 4989.0 5004.3 5017.5 5070.1 5785.1 5840.8 5841.4 5994.3 6002.1 5725.7 5797.4 5804.3 5874.7 5886.0 5961.3 5963.0 5966.3 5976.7 6042.1 5676.2 5676.9 5680.3 5680.5 5681.7 5526.5 5541.8 5697.5 5702.4 5727.3 5633.4 5634.2 5636.0 5636.5 5692.7 5544.4 5562.1 5619.2 5619.9 5623.0 5255.2 5387.4 5529.8 5595.4 5608.2 5721.3 5724.4 5724.7 5749.2 5787.5 5566.1 5576.7 5582.2 5582.4 5631.5 10:51:40 INFO - PROCESS | 3416 | 10:51:40 INFO - PROCESS | 3416 | [#1] ext.html Cycles:180 Average:55590.33 Median:38079.68 stddev:103259.74 (271.2%) stddev-sans-first:103466.71 10:51:40 INFO - PROCESS | 3416 | Values: 548.0 571.3 598.7 616.1 622.1 32223.5 32979.0 35382.5 35388.5 35429.8 34961.3 44518.0 45382.3 45449.5 48956.3 8692.2 8819.4 8826.4 8829.2 8829.6 8636.1 8736.7 8741.6 8742.2 8752.0 8011.2 8196.3 8198.2 10344.1 10584.0 10638.9 10702.0 10707.7 10708.3 10711.3 10452.5 10541.3 10543.2 10546.2 10548.7 42082.4 42408.4 42413.2 42435.4 42444.0 3293.6 3376.5 3405.4 3456.7 3517.3 31236.0 32156.7 32259.8 32284.5 32300.8 4180.6 4327.2 4342.4 4367.3 4537.2 324378.0 324986.0 325273.0 326158.0 326323.0 58267.7 58461.0 58580.4 58625.0 58652.4 61412.0 61434.4 61516.4 61518.0 61626.7 14620.0 14835.2 14842.6 14845.8 14845.9 10862.3 10863.8 10866.7 10868.5 10870.8 13088.7 17123.4 17181.7 17198.6 17396.1 5053.2 5749.0 5821.8 5881.4 5883.9 904.2 963.2 1018.8 1027.7 1041.8 31433.0 31488.5 31534.4 32158.4 32488.7 1133.2 1149.7 1155.2 1157.4 1159.4 16349.9 16696.4 16702.8 16895.9 17136.2 473579.0 477047.0 478671.0 478984.0 481407.0 58116.7 58279.0 58342.0 58407.7 58427.7 1181.2 1234.5 1257.9 1264.3 1311.9 29069.0 32681.3 32804.5 32881.0 33679.3 50417.7 50940.5 50952.5 50976.2 51007.0 352258.0 352968.0 353632.0 353892.0 355291.0 40271.8 40643.0 41494.7 41583.2 41603.0 46909.0 47630.5 47725.0 47734.0 48230.5 39130.1 39521.6 40468.4 40533.0 42081.6 39878.6 40501.6 40535.6 41113.8 42160.2 40015.0 40445.6 40743.2 41101.0 41248.8 33917.5 36065.6 36581.6 36999.6 37029.3 27283.3 27717.9 27796.9 27798.3 27809.0 10:51:40 INFO - PROCESS | 3416 | 10:51:40 INFO - PROCESS | 3416 | [#2] jquery.html Cycles:180 Average:28333.16 Median:23066.04 stddev:76305.45 (330.8%) stddev-sans-first:76490.63 10:51:40 INFO - PROCESS | 3416 | Values: 374.6 380.6 399.7 400.5 419.6 13210.1 15298.4 16288.7 19279.7 19386.2 19028.0 19129.4 19223.5 19421.5 19557.8 5477.2 5529.7 5727.2 5729.5 5738.4 4519.4 5664.8 5690.5 5694.3 5695.6 5418.5 5657.7 5659.5 5659.9 5666.5 5602.1 5641.3 5642.5 5648.2 5679.8 4822.5 5053.9 5061.0 5061.7 5090.5 22957.4 22988.7 23032.5 23099.5 23251.8 2256.8 2518.2 2934.5 2960.0 2989.7 13639.2 14637.9 14657.7 14730.8 14883.7 1917.7 1942.8 1950.8 2019.1 2077.6 80560.6 81211.0 81705.6 81756.6 81760.6 10058.9 10324.4 10431.5 10529.2 10929.1 14594.7 14630.9 14636.0 14639.6 14668.3 6568.7 6836.8 6882.7 7092.0 7113.4 6138.3 6190.9 6275.7 6324.8 6369.7 6404.2 6411.6 6426.5 6457.3 6606.7 1861.7 1881.6 1931.0 1931.5 1936.2 958.0 968.5 1002.6 1025.5 1043.4 19362.5 19755.8 19866.7 19919.6 20243.0 991.4 994.9 1056.4 1056.9 1106.6 10344.9 10404.0 11261.5 11334.1 11500.3 434287.0 450614.0 461381.0 473350.9 482048.0 96868.5 98173.0 98538.0 101378.0 103367.5 994.9 1061.7 1066.6 1068.1 1078.1 16894.8 16902.8 17490.8 17890.5 18169.5 38452.2 43670.0 43934.6 43935.0 44790.8 46876.0 55433.4 56825.7 57721.7 57975.0 8392.2 8398.9 8459.7 8665.4 8861.6 12635.7 13086.5 13246.3 13495.1 13627.0 11445.3 11469.4 11841.9 12086.2 12436.7 10975.6 11008.0 11054.2 11302.8 11910.2 11478.6 11513.0 11530.1 11573.5 11904.6 7588.7 7837.6 8251.3 8824.1 8851.6 11260.8 11644.0 11955.9 12089.4 12676.6 10:51:40 INFO - PROCESS | 3416 | 10:51:40 INFO - PROCESS | 3416 | [#3] mootools.html Cycles:180 Average:5812.88 Median:2460.42 stddev:3408.24 (138.5%) stddev-sans-first:3401.12 10:51:40 INFO - PROCESS | 3416 | Values: 1326.0 1426.1 1486.1 1606.3 1791.9 7878.0 8472.2 8756.7 8772.1 9026.4 8824.3 8882.3 8900.9 8910.1 8918.3 2310.1 2326.4 2328.5 2331.1 2338.1 2242.6 2289.5 2316.1 2318.8 2329.3 2238.9 2258.9 2272.9 2293.0 2301.0 2188.3 2196.6 2218.3 2227.7 2231.8 2213.1 2266.5 2266.5 2273.3 2276.1 8985.4 9062.5 9124.6 9132.6 9171.1 5424.3 5552.1 5559.0 5561.4 5569.4 3536.2 3563.4 3599.5 3621.5 3626.6 1145.7 1146.8 1150.4 1163.2 1172.7 12479.2 12519.9 12569.6 12576.1 12577.3 4469.2 4623.3 4748.1 4776.5 4812.6 9978.2 10011.1 10113.9 10122.3 10125.2 5383.9 5422.6 5434.0 5436.7 5437.8 4225.0 4306.4 4435.1 4993.8 5088.3 3682.1 3776.7 3794.0 3842.4 3895.6 1162.5 1170.7 1179.2 1189.5 1191.3 928.8 935.0 943.0 958.3 979.6 5687.3 5713.2 5759.3 5817.9 6190.2 435.1 436.7 442.2 444.1 451.6 3843.2 3971.1 4011.4 4032.3 4117.8 11287.2 11469.9 11549.1 11550.9 11697.4 11417.8 11444.1 11453.1 11454.4 11460.0 8044.5 8054.4 8129.2 8174.6 8183.3 5700.5 5704.9 5745.9 5760.0 5915.9 10312.9 10420.4 10454.7 10468.9 10643.9 9918.4 10330.1 10336.2 10613.9 10660.9 7052.7 7160.9 7221.1 7749.7 7921.3 8109.8 8167.7 8369.2 8474.0 8553.1 7796.1 7914.6 8054.6 8059.3 8147.9 7631.8 7696.8 7776.1 7780.4 7822.8 6810.4 6910.2 6915.0 6921.1 6924.9 4828.3 4846.5 4866.8 4980.0 5054.3 4862.9 4954.7 5051.8 5077.2 5148.9 10:51:40 INFO - PROCESS | 3416 | 10:51:40 INFO - PROCESS | 3416 | [#4] prototype.html Cycles:180 Average:4544.19 Median:5191.75 stddev:1329.74 (25.6%) stddev-sans-first:1295.24 10:51:40 INFO - PROCESS | 3416 | Values: 326.3 326.3 334.6 336.1 340.7 5063.7 5169.7 5210.3 5248.3 5249.7 5027.7 5080.6 5096.3 5117.3 5199.6 4082.6 4090.6 4112.3 4120.3 4127.4 3960.9 4065.7 4111.0 4132.3 4153.0 4046.6 4061.2 4071.9 4088.1 4092.9 4060.9 4062.7 4063.8 4065.2 4085.7 3637.2 3646.1 3648.4 3652.2 3667.5 4861.8 5047.7 5050.5 5075.1 5090.8 4596.8 4598.6 4609.9 4637.5 4642.3 5375.7 5394.0 5396.1 5409.2 5413.5 3663.9 3829.3 3847.3 3912.2 3913.8 5571.5 5617.3 5622.9 5646.8 5657.7 4005.2 4005.6 4013.6 4014.2 4017.9 3952.2 4009.2 4052.4 4057.3 4066.9 4582.8 4592.4 4599.0 4603.9 4609.8 5383.8 5414.4 5418.3 5420.0 5444.9 1283.8 1297.3 1330.4 1331.4 1378.1 879.4 898.0 905.9 906.5 912.6 4613.4 4627.7 4635.7 4639.3 4663.0 4888.6 4918.3 4918.3 5233.6 5646.3 5250.4 5256.7 5265.6 5273.4 5329.3 2913.3 2944.2 2956.9 2963.5 2963.6 5489.5 5717.3 5758.0 5764.9 5775.7 5627.6 5645.9 5664.7 5674.4 5677.3 5486.3 5748.4 5753.6 5799.4 5817.3 5527.3 5532.9 5535.3 5546.3 5554.8 5500.9 5507.8 5508.5 5534.7 5563.7 5411.5 5667.8 5687.0 5805.5 5809.8 3967.2 3973.1 4008.6 4036.1 4040.8 5613.4 5615.4 5644.9 5649.5 5652.2 5270.8 5410.6 5436.6 5456.8 5505.6 5369.6 5377.4 5385.3 5386.3 5420.2 5183.9 5286.5 5299.6 5305.8 5315.2 5085.5 5402.0 5446.9 5450.2 5484.4 5231.3 5329.9 5333.7 5335.5 5346.3 10:51:40 INFO - PROCESS | 3416 | 10:51:40 INFO - PROCESS | 3416 | [#5] yui.html Cycles:180 Average:21047.62 Median:4456.54 stddev:30727.69 (689.5%) stddev-sans-first:30776.00 10:51:40 INFO - PROCESS | 3416 | Values: 723.9 729.3 753.0 762.2 872.9 14897.6 14970.0 15035.1 15618.0 16638.9 15152.9 15752.4 15840.8 15880.1 15906.2 798.1 824.4 826.5 826.9 827.0 674.0 690.5 793.2 803.2 804.9 862.8 865.7 866.6 866.8 866.9 856.3 856.7 857.0 857.6 857.7 514.6 523.0 615.0 620.6 629.7 15164.5 15247.2 15266.3 15304.6 15308.8 13891.0 14200.4 14567.3 14589.6 14613.0 13059.9 13219.0 13246.6 13405.7 14140.2 4410.0 4436.5 4449.7 4451.3 4513.0 77148.6 77344.6 79575.6 80054.2 80558.0 10276.2 11233.0 11326.0 11441.4 11874.1 20813.6 20845.6 20852.8 20854.2 20868.6 7905.8 8048.5 8072.3 8223.8 8286.3 4489.0 4611.4 4659.2 4670.7 4781.2 3309.4 3388.1 3418.5 3425.8 3428.2 599.6 607.7 610.7 619.1 636.9 654.7 661.5 671.6 691.1 695.9 9302.0 9381.0 9423.2 9424.8 9447.9 691.3 698.9 709.9 727.3 746.5 3652.7 3986.7 4429.2 4443.5 4461.8 76651.6 84987.2 125242.4 126411.0 127420.4 104381.5 105071.5 105720.5 106708.0 109400.0 74549.6 91468.5 91599.0 91604.5 92211.5 8856.9 8942.4 9023.5 9143.9 9152.1 52958.7 53266.5 53269.5 54254.1 54811.5 73530.6 76424.0 80273.6 80870.6 82807.0 11529.3 11551.1 11631.1 11647.4 12070.9 13047.7 13082.1 13111.3 13135.3 13814.1 11902.2 12198.9 12200.3 12475.4 13153.1 10831.5 13574.5 13682.7 13767.6 13984.8 13788.4 13880.9 13998.2 14169.5 14538.3 10725.0 10743.3 10863.3 11057.9 12526.1 11494.7 11649.3 11704.2 11810.5 12054.5 10:51:40 INFO - PROCESS | 3416 | -------- Summary: end -------- 10:51:40 INFO - PROCESS | 3416 | 10:51:41 INFO - TEST-INFO | 3416: exit 0 10:51:41 INFO - TEST-OK | dromaeo_css | took 1122263ms 10:51:41 INFO - TEST-START | kraken 10:51:41 INFO - operating with platform_type : linux_ 10:51:41 INFO - Initialising browser for kraken test... 10:51:41 INFO - TEST-INFO | started process 3721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfLq4ei/profile http://localhost:38513/getInfo.html) 10:51:45 INFO - PROCESS | 3721 | __metrics Screen width/height:1600/1200 10:51:45 INFO - PROCESS | 3721 | colorDepth:24 10:51:45 INFO - PROCESS | 3721 | Browser inner width/height: 1024/697 10:51:45 INFO - PROCESS | 3721 | __metrics 10:51:46 INFO - PROCESS | 3721 | 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" 10:51:46 INFO - PROCESS | 3721 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:51:47 INFO - PROCESS | 3721 | console.error: PushService: 10:51:47 INFO - PROCESS | 3721 | stateChangeProcessEnqueue: Error transitioning state 10:51:47 INFO - PROCESS | 3721 | UnknownError 10:51:47 INFO - TEST-INFO | 3721: exit 0 10:51:47 INFO - Browser initialized. 10:51:47 INFO - Running cycle 1/1 for kraken test... 10:51:47 INFO - TEST-INFO | started process 3802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfLq4ei/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:59 INFO - PROCESS | 3802 | RSS: Main: 171794432 10:51:59 INFO - PROCESS | 3802 | 10:52:02 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38513/tests/kraken/driver.html?testName=audio-beat-detection) 10:52:03 INFO - PROCESS | 3802 | RSS: Main: 228679680 10:52:03 INFO - PROCESS | 3802 | 10:52:05 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38513/tests/kraken/driver.html?testName=audio-dft) 10:52:06 INFO - PROCESS | 3802 | RSS: Main: 215973888 10:52:06 INFO - PROCESS | 3802 | 10:52:09 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38513/tests/kraken/driver.html?testName=audio-fft) 10:52:10 INFO - PROCESS | 3802 | RSS: Main: 297058304 10:52:10 INFO - PROCESS | 3802 | 10:52:12 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38513/tests/kraken/driver.html?testName=audio-oscillator) 10:52:12 INFO - PROCESS | 3802 | RSS: Main: 206143488 10:52:12 INFO - PROCESS | 3802 | 10:52:14 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38513/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:52:15 INFO - PROCESS | 3802 | RSS: Main: 212062208 10:52:15 INFO - PROCESS | 3802 | 10:52:18 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38513/tests/kraken/driver.html?testName=imaging-darkroom) 10:52:19 INFO - PROCESS | 3802 | RSS: Main: 247803904 10:52:19 INFO - PROCESS | 3802 | 10:52:22 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38513/tests/kraken/driver.html?testName=imaging-desaturate) 10:52:23 INFO - PROCESS | 3802 | RSS: Main: 247177216 10:52:23 INFO - PROCESS | 3802 | 10:52:25 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38513/tests/kraken/driver.html?testName=json-parse-financial) 10:52:26 INFO - PROCESS | 3802 | RSS: Main: 245665792 10:52:26 INFO - PROCESS | 3802 | 10:52:27 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38513/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:52:28 INFO - PROCESS | 3802 | RSS: Main: 208752640 10:52:28 INFO - PROCESS | 3802 | 10:52:30 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:52:30 INFO - PROCESS | 3802 | RSS: Main: 216801280 10:52:30 INFO - PROCESS | 3802 | 10:52:32 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:52:33 INFO - PROCESS | 3802 | RSS: Main: 225492992 10:52:33 INFO - PROCESS | 3802 | 10:52:36 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:52:36 INFO - PROCESS | 3802 | RSS: Main: 234450944 10:52:36 INFO - PROCESS | 3802 | 10:52:39 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:52:40 INFO - PROCESS | 3802 | RSS: Main: 231374848 10:52:40 INFO - PROCESS | 3802 | 10:52:41 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38513/tests/kraken/driver.html?testName=ai-astar) 10:52:42 INFO - PROCESS | 3802 | RSS: Main: 282660864 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | __start_tp_report 10:52:42 INFO - PROCESS | 3802 | _x_x_mozilla_page_load 10:52:42 INFO - PROCESS | 3802 | _x_x_mozilla_page_load_details 10:52:42 INFO - PROCESS | 3802 | |i|pagename|runs| 10:52:42 INFO - PROCESS | 3802 | |0;ai-astar;103;113;111;111;112;111;112;111;109;113 10:52:42 INFO - PROCESS | 3802 | |1;audio-beat-detection;150;121;121;157;123;122;120;121;155;119 10:52:42 INFO - PROCESS | 3802 | |2;audio-dft;162;161;161;161;161;162;162;160;162;161 10:52:42 INFO - PROCESS | 3802 | |3;audio-fft;75;76;76;115;76;75;75;76;99;76 10:52:42 INFO - PROCESS | 3802 | |4;audio-oscillator;83;82;129;83;83;82;108;82;83;111 10:52:42 INFO - PROCESS | 3802 | |5;imaging-gaussian-blur;117;116;116;117;117;116;117;116;118;117 10:52:42 INFO - PROCESS | 3802 | |6;imaging-darkroom;147;146;146;146;145;147;145;146;145;147 10:52:42 INFO - PROCESS | 3802 | |7;imaging-desaturate;84;85;84;85;85;85;85;84;84;84 10:52:42 INFO - PROCESS | 3802 | |8;json-parse-financial;56;53;54;53;54;54;54;54;54;53 10:52:42 INFO - PROCESS | 3802 | |9;json-stringify-tinderbox;59;61;60;62;61;60;60;60;59;60 10:52:42 INFO - PROCESS | 3802 | |10;stanford-crypto-aes;88;80;88;83;80;80;81;80;80;79 10:52:42 INFO - PROCESS | 3802 | |11;stanford-crypto-ccm;131;147;130;132;131;136;144;147;172;136 10:52:42 INFO - PROCESS | 3802 | |12;stanford-crypto-pbkdf2;170;169;174;168;171;167;170;172;171;169 10:52:42 INFO - PROCESS | 3802 | |13;stanford-crypto-sha256-iterative;68;66;66;66;67;66;67;66;67;66 10:52:42 INFO - PROCESS | 3802 | __end_tp_report 10:52:42 INFO - PROCESS | 3802 | __start_cc_report 10:52:42 INFO - PROCESS | 3802 | _x_x_mozilla_cycle_collect,1684 10:52:42 INFO - PROCESS | 3802 | __end_cc_report 10:52:42 INFO - PROCESS | 3802 | __startTimestamp1476726762061__endTimestamp 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | ------- Summary: start ------- 10:52:42 INFO - PROCESS | 3802 | Number of tests: 14 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.91 (2.6%) stddev-sans-first:1.24 10:52:42 INFO - PROCESS | 3802 | Values: 103.0 113.0 111.0 111.0 112.0 111.0 112.0 111.0 109.0 113.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:122.50 stddev:16.07 (13.1%) stddev-sans-first:15.48 10:52:42 INFO - PROCESS | 3802 | Values: 150.0 121.0 121.0 157.0 123.0 122.0 120.0 121.0 155.0 119.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 10:52:42 INFO - PROCESS | 3802 | Values: 162.0 161.0 161.0 161.0 161.0 162.0 162.0 160.0 162.0 161.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.76 (18.1%) stddev-sans-first:14.37 10:52:42 INFO - PROCESS | 3802 | Values: 75.0 76.0 76.0 115.0 76.0 75.0 75.0 76.0 99.0 76.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:82.50 stddev:17.02 (20.6%) stddev-sans-first:17.69 10:52:42 INFO - PROCESS | 3802 | Values: 83.0 82.0 129.0 83.0 83.0 82.0 108.0 82.0 83.0 111.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:52:42 INFO - PROCESS | 3802 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 118.0 117.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 10:52:42 INFO - PROCESS | 3802 | Values: 147.0 146.0 146.0 146.0 145.0 147.0 145.0 146.0 145.0 147.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 10:52:42 INFO - PROCESS | 3802 | Values: 84.0 85.0 84.0 85.0 85.0 85.0 85.0 84.0 84.0 84.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.50 10:52:42 INFO - PROCESS | 3802 | Values: 56.0 53.0 54.0 53.0 54.0 54.0 54.0 54.0 54.0 53.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 10:52:42 INFO - PROCESS | 3802 | Values: 59.0 61.0 60.0 62.0 61.0 60.0 60.0 60.0 59.0 60.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:80.50 stddev:3.38 (4.2%) stddev-sans-first:2.77 10:52:42 INFO - PROCESS | 3802 | Values: 88.0 80.0 88.0 83.0 80.0 80.0 81.0 80.0 80.0 79.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:140.00 stddev:12.88 (9.2%) stddev-sans-first:13.18 10:52:42 INFO - PROCESS | 3802 | Values: 131.0 147.0 130.0 132.0 131.0 136.0 144.0 147.0 172.0 136.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:170.50 stddev:2.02 (1.2%) stddev-sans-first:2.15 10:52:42 INFO - PROCESS | 3802 | Values: 170.0 169.0 174.0 168.0 171.0 167.0 170.0 172.0 171.0 169.0 10:52:42 INFO - PROCESS | 3802 | 10:52:42 INFO - PROCESS | 3802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:0.71 (1.1%) stddev-sans-first:0.50 10:52:42 INFO - PROCESS | 3802 | Values: 68.0 66.0 66.0 66.0 67.0 66.0 67.0 66.0 67.0 66.0 10:52:42 INFO - PROCESS | 3802 | -------- Summary: end -------- 10:52:42 INFO - PROCESS | 3802 | 10:52:43 INFO - TEST-INFO | 3802: exit 0 10:52:43 INFO - TEST-OK | kraken | took 61971ms 10:52:43 INFO - SUITE-END | took 1184s 10:52:43 INFO - Completed test suite (00:19:44) 10:52:43 INFO - javascript benchmark 10:52:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2878.899238526652, 2949.2331993681637, 2950.8377039262837, 2956.911292661221, 2990.117915215011, 5195.19474481456, 5268.209768534722, 5294.682319060854, 5410.404855465896, 5506.284183056202, 5296.3379577552805, 5329.467053294668, 5387.057264978623, 5425.294711687475, 5446.183072539121, 4839.806407743704, 4872.683275587093, 4913.680610760307, 4919.631027672921, 4975.776090075937, 4866.245731911559, 4971.502849715036, 5030.949690503085, 5042.798288068473, 5070.492950704936, 4724.5039270876405, 4763.523647635244, 4823.758812059418, 4898.118338699051, 4903.852884413455, 4793.49668284832, 4803.279508073782, 4816.555033489974, 4857.222844344923, 4920.507949205086, 4774.832880849153, 4803.327534145223, 4816.61467082636, 4819.590334821544, 4876.146674331978, 5302.628815982883, 5322.281491998569, 5325.840224793263, 5326.147816349366, 5347.759350829222, 5507.091329930557, 5537.667739935577, 5716.8856622867725, 5761.3950535194035, 5792.623479473821, 5888.5289176865745, 5904.0, 5904.232449781543, 5957.970210148921, 5977.521798256129, 5469.835904922819, 5488.725563721798, 5489.533389661844, 5489.533389661844, 5489.58828087895, 5651.519620832275, 5654.236678048493, 5708.429157084258, 5997.400259973968, 6003.759849605967, 5514.558835293167, 5519.254900588369, 5521.033819081645, 5527.115661494142, 5555.638883472561, 5568.832935011957, 5573.247611572386, 5582.91625625616, 5583.218349431083, 5584.106542953189, 5570.470805273492, 5591.0, 5591.832245032656, 5592.944070559242, 5594.440555944454, 5595.664260144405, 5596.608237423341, 5599.692016939108, 5601.271834661468, 5605.271314729059, 4337.436133302651, 4357.128574285092, 4358.171947329997, 4358.346248062816, 4359.455068116486, 3864.8260828262796, 3884.067823722343, 3905.1799122184093, 3905.8437662493184, 3908.726389152732, 5453.182022696627, 5453.836384908459, 5454.563634909197, 5462.781488740406, 5532.30846144232, 5563.527100196528, 5618.943810561842, 5777.306723193244, 5780.306363236438, 5790.768369265183, 5367.946320536745, 5410.1343784994215, 5422.295101636841, 5454.781808727606, 5455.208994695826, 4986.90026199474, 4988.975055124701, 5004.3494345734825, 5017.523335283142, 5070.112730272188, 5785.074388097884, 5840.8247752567495, 5841.386654401226, 5994.250718660168, 6002.069679199731, 5725.713714314351, 5797.362290147996, 5804.303483581997, 5874.676892770939, 5885.970570147122, 5961.344252132349, 5962.970185149046, 5966.3138739043825, 5976.701164941648, 6042.093685947143, 5676.17695434168, 5676.893005863817, 5680.318361796611, 5680.545556355564, 5681.744321505625, 5526.50261476469, 5541.806036788693, 5697.487226149667, 5702.372738998624, 5727.255456790591, 5633.4366563344975, 5634.2393776841245, 5635.971820140873, 5636.4927156556105, 5692.743826527733, 5544.390117087198, 5562.082256427806, 5619.185218143264, 5619.943800561942, 5623.0, 5255.185446255837, 5387.407385187548, 5529.778808847601, 5595.35653399848, 5608.186812912187, 5721.256236689203, 5724.398938111438, 5724.656520608777, 5749.223854779551, 5787.479126878601, 5566.081596536526, 5576.749046293007, 5582.162675598693, 5582.441755824385, 5631.549476041989], "value": 5272.282080065079, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.9603188467092, 571.2830397850698, 598.6617561077991, 616.11587372121, 622.073111064514, 32223.51664725031, 32979.0, 35382.46926296107, 35388.469172962425, 35429.82285088574, 34961.32906044867, 44518.0, 45382.319265211045, 45449.54550454503, 48956.2656560151, 8692.174243446863, 8819.382643214978, 8826.382153249275, 8829.16122968317, 8829.602667879928, 8636.093210212932, 8736.650533978665, 8741.606627701736, 8742.169493898102, 8752.037275899645, 8011.158828323, 8196.3033142183, 8198.221168988937, 10344.120749736281, 10584.047435730783, 10638.893611063906, 10702.0, 10707.732306692316, 10708.25042247043, 10711.303765255312, 10452.477376131163, 10541.262111652188, 10543.156547476183, 10546.209034322379, 10548.683539493828, 42082.368764468556, 42408.36387454191, 42413.15173696509, 42435.36346954767, 42444.0, 3293.637699853014, 3376.5104059911178, 3405.3700065487715, 3456.723462123049, 3517.3317069756663, 31236.0, 32156.678433215602, 32259.83870080658, 32284.515732264033, 32300.838495807606, 4180.561041090703, 4327.221100201962, 4342.435483387139, 4367.3448982652535, 4537.160625284333, 324378.0, 324986.0, 325273.0, 326157.9999999976, 326323.0, 58267.70866145642, 58461.0, 58580.4141958575, 58625.0, 58652.4134758647, 61412.0, 61434.38565614376, 61516.38483615107, 61518.0, 61626.69186654038, 14620.049696769676, 14835.18406487632, 14842.628934276729, 14845.777313340308, 14845.851541484662, 10862.293950893167, 10863.83704244437, 10866.67399978002, 10868.45657717111, 10870.782584348268, 13088.672137825555, 17123.400680976105, 17181.656366872594, 17198.570035748955, 17396.085880676746, 5053.216751403538, 5748.971255143698, 5821.768918250412, 5881.441263080001, 5883.94116058834, 904.2133343990639, 963.2486660404755, 1018.8420794776821, 1027.6557353286582, 1041.8489319048695, 31433.0, 31488.527672084936, 31534.36931261408, 32158.35683286321, 32488.675113248566, 1133.21241736992, 1149.672343382132, 1155.1625071822862, 1157.3634501024403, 1159.368144361325, 16349.918250408671, 16696.41562545305, 16702.83297167037, 16895.915520422564, 17136.22886970089, 473579.0, 477047.0, 478671.0, 478984.0, 481407.0, 58116.70941645265, 58279.0, 58342.0, 58407.70796146077, 58427.70786146042, 1181.2026881854713, 1234.5432190089725, 1257.9433925473375, 1264.3362234826973, 1311.8556958734532, 29069.0, 32681.34637307193, 32804.507932380555, 32881.0, 33679.32641347208, 50417.74791126021, 50940.49059509357, 50952.49047509626, 50976.235356470424, 51007.0, 352258.0, 352968.0, 353632.0, 353892.0, 355291.0, 40271.79864100661, 40643.0, 41494.71779052181, 41583.1683366337, 41603.0, 46909.0, 47630.52369476261, 47725.0, 47734.0, 48230.517694824004, 39130.109260433695, 39521.60478395179, 40468.392974106, 40533.0, 42081.57918420777, 39878.60121398749, 40501.594984050964, 40535.594644053184, 41113.79443102765, 42160.1567968645, 40015.0, 40445.59554404418, 40743.1851362977, 41101.0, 41248.79375603103, 33917.49123763195, 36065.5573777046, 36581.63418365889, 36999.63000369962, 37029.25941481209, 27283.31791705223, 27717.861410692818, 27796.86101569479, 27798.305042374104, 27809.0], "value": 19699.428764004566, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.55802153458944, 380.61177598849173, 399.7082130045067, 400.4933758795125, 419.61185903039683, 13210.141340812852, 15298.388064477422, 16288.674226515477, 19279.710804337945, 19386.22455101798, 19028.0, 19129.42611721647, 19223.519412014706, 19421.514462138417, 19557.80442195581, 5477.178423236526, 5529.668219906818, 5727.169560413738, 5729.541636669077, 5738.368779434259, 4519.389882365871, 5664.773409063632, 5690.516306113986, 5694.316681998166, 5695.629784064023, 5418.512333889949, 5657.745401456944, 5659.490645841874, 5659.915101273484, 5666.51834594058, 5602.1036634138345, 5641.294838145232, 5642.520385767194, 5648.181013752983, 5679.829605111832, 4822.469528351879, 5053.862880851816, 5061.038402703512, 5061.746912654353, 5090.490950904917, 22957.426064348358, 22988.65517017246, 23032.53934921309, 23099.53800923989, 23251.7674823253, 2256.8420210585264, 2518.2319392585255, 2934.4571254317807, 2959.970400295991, 2989.744307390901, 13639.195243624745, 14637.926810365987, 14657.706845863024, 14730.779038314435, 14883.70232595342, 1917.7411049508278, 1942.7960064193198, 1950.804919508052, 2019.1216820682903, 2077.574097310048, 80560.59719701423, 81211.0, 81705.59147204286, 81756.59121704413, 81760.59119704422, 10058.899411005943, 10324.43215623148, 10431.478426078666, 10529.157667386591, 10929.071028962628, 14594.737815638593, 14630.853691463162, 14636.04865683727, 14639.634009149644, 14668.339924703414, 6568.7372505099265, 6836.794896153124, 6882.69027893746, 7091.964540177266, 7113.395361394236, 6138.263408391022, 6190.876182476415, 6275.654838983808, 6324.841878952971, 6369.7452101915405, 6404.167458230493, 6411.551191416649, 6426.485881129498, 6457.2896981332015, 6606.702698378488, 1861.692820684599, 1881.6330815490849, 1931.0, 1931.4750580191208, 1936.2203821592534, 958.0205560706198, 968.5496244246459, 1002.5638847101534, 1025.487256371814, 1043.3739756146251, 19362.515937101405, 19755.802441975684, 19866.70199947002, 19919.60160796776, 20243.0, 991.3853410885297, 994.8855881573712, 1056.445366182745, 1056.8784589772274, 1106.5573770491867, 10344.948275258575, 10404.0, 11261.514294378165, 11334.129868571594, 11500.309981401142, 434287.0, 450614.0, 461381.0, 473350.9445645693, 482048.0, 96868.51565742126, 98173.0, 98538.0, 101378.0, 103367.48316258371, 994.9005099489993, 1061.6708820265742, 1066.5840322274319, 1068.0921216965517, 1078.0890147825075, 16894.831051689816, 16902.83097169062, 17490.764208621447, 17890.463286101436, 18169.454916352002, 38452.230955380175, 43670.0, 43934.56065439305, 43935.0, 44790.77604611956, 46876.0, 55433.44566554283, 56825.715871420376, 57721.711391442775, 57975.0, 8392.244697977212, 8398.874016889873, 8459.661613535389, 8665.43674661145, 8861.64553417856, 12635.684107897376, 13086.541971030969, 13246.337683115999, 13495.122817016863, 13627.0, 11445.25605835618, 11469.369184694922, 11841.940790295994, 12086.214396064228, 12436.689082773004, 10975.615853445091, 11008.009279164593, 11054.170937179582, 11302.830457543309, 11910.166288359731, 11478.598249061242, 11513.0, 11530.077593792308, 11573.511694985618, 11904.642860714192, 7588.696452141852, 7837.568933708701, 8251.2986396157, 8824.117588241124, 8851.645934162561, 11260.774784504429, 11644.0, 11955.880441195477, 12089.39553022363, 12676.619701408972], "value": 9241.634688314809, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.045247421856, 1426.0944300369265, 1486.0563542150733, 1606.333371650765, 1791.9104044797748, 7877.960610196948, 8472.195141461567, 8756.737297881058, 8772.078931712158, 9026.36815422919, 8824.294056475483, 8882.333824963122, 8900.866487002684, 8910.108989101087, 8918.331125165607, 2310.1106074161403, 2326.4300246439648, 2328.52265285616, 2331.067572970817, 2338.0764597983784, 2242.5627002734473, 2289.4848659051745, 2316.143027079974, 2318.8144948404088, 2329.2546385156757, 2238.88055972014, 2258.9435264118447, 2272.874991875446, 2292.9770702293013, 2300.9884950575224, 2188.2559929624003, 2196.5716685246384, 2218.267971569386, 2227.66585012247, 2231.7656646052174, 2213.1368766181204, 2266.46738016566, 2266.5353602511445, 2273.283915566608, 2276.06681260684, 8985.37102402832, 9062.501562414065, 9124.635014599407, 9132.634694612207, 9171.128742769426, 5424.321959755031, 5552.11166213408, 5559.0, 5561.443855614447, 5569.443055694439, 3536.2043540203504, 3563.4120370138894, 3599.4780756790383, 3621.5473065866768, 3626.601073881871, 1145.6792098212513, 1146.7821113988316, 1150.4362862197463, 1163.2264544078178, 1172.724409763705, 12479.19051737493, 12519.874801251963, 12569.622911312676, 12576.056795740356, 12577.308248046354, 4469.217886869785, 4623.329617205486, 4748.074125545486, 4776.546228108394, 4812.590929770939, 9978.151857092083, 10011.099001089791, 10113.949430252802, 10122.291439599157, 10125.240606954509, 5383.865403364869, 5422.620416570802, 5434.049041417736, 5436.70098144598, 5437.8368648940595, 4225.0, 4306.375575541529, 4435.068635586563, 4993.775280112403, 5088.313077734532, 3682.1346983458866, 3776.66010059096, 3794.032521706947, 3842.442845787401, 3895.6493915547735, 1162.511745067074, 1170.7190274334098, 1179.2099293473393, 1189.5063548627395, 1191.2614179208947, 928.8281667891462, 935.0182308575968, 942.990570094304, 958.3483231402573, 979.5591983607405, 5687.260656114761, 5713.171590119409, 5759.2512973313205, 5817.883642327214, 6190.226221722285, 435.0776354129266, 436.6594056635829, 442.16872280113824, 444.0785370356523, 451.61612629264863, 3843.2121415109837, 3971.0866500705, 4011.358182690814, 4032.2943484890616, 4117.794110294473, 11287.153463490271, 11469.88530114705, 11549.13381496391, 11550.902664246883, 11697.415129243504, 11417.771644567061, 11444.14168937333, 11453.14101442395, 11454.427278636034, 11460.02589779878, 8044.517328960164, 8054.436189466798, 8129.227723366271, 8174.550399728072, 8183.263506284582, 5700.543956483554, 5704.914426283526, 5745.885082298414, 5759.971200143972, 5915.940840591539, 10312.896871031193, 10420.426876521864, 10454.738631533968, 10468.94765526198, 10643.94678026605, 9918.40489570628, 10330.121939635215, 10336.17310615134, 10613.893861061291, 10660.946695266473, 7052.717891284291, 7160.856782864418, 7221.097362829646, 7749.651265692944, 7921.287084162453, 8109.75670729879, 8167.714130005421, 8369.163083691583, 8473.95763021181, 8553.144685531397, 7796.103448103314, 7914.564698941614, 8054.556999364857, 8059.274665280153, 8147.877781833158, 7631.771046868603, 7696.769096927102, 7776.066871975399, 7780.377569794516, 7822.843543128992, 6810.421114205348, 6910.205326387329, 6915.0, 6921.1002569665625, 6924.861502770017, 4828.324034635084, 4846.5153484652665, 4866.8053277868485, 4980.0, 5054.342935418372, 4862.857228551358, 4954.65317427791, 5051.823186188466, 5077.162268225849, 5148.871278218075], "value": 4530.64374996588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.2577635878377, 326.26101879243504, 334.64527600743213, 336.10595815131745, 340.73763202334186, 5063.696178229309, 5169.715665638389, 5210.270562121302, 5248.343957005374, 5249.71126588038, 5027.673201241917, 5080.618953578487, 5096.311997880285, 5117.257997590347, 5199.610029247812, 4082.632563069323, 4090.5887468823207, 4112.321466957948, 4120.299549076664, 4127.422160897462, 3960.9007226170033, 4065.6544193743566, 4110.958890411102, 4132.318167502373, 4152.958470415288, 4046.6358027777496, 4061.208064427438, 4071.857484988026, 4088.10061786408, 4092.877213683594, 4060.8984775380554, 4062.659322423593, 4063.79681015948, 4065.1869626074904, 4085.673146148316, 3637.163452405935, 3646.0520264731094, 3648.361536731088, 3652.1600031992525, 3667.541557305337, 4861.805527778884, 5047.722375269359, 5050.469700681412, 5075.111855425286, 5090.796368145269, 4596.770161491912, 4598.563136502027, 4609.916669582645, 4637.489876113625, 4642.303654451825, 5375.731213439312, 5394.0, 5396.10964190908, 5409.215663728776, 5413.512783849473, 3663.9267214655824, 3829.349010668193, 3847.3267178243696, 3912.2371137628174, 3913.784741839226, 5571.470710282517, 5617.325920889479, 5622.859428514279, 5646.802361917313, 5657.688827114466, 4005.2189822984237, 4005.5794141615293, 4013.6387725104296, 4014.1770936957855, 4017.879463616038, 3952.2293152835496, 4009.1781184857036, 4052.371882358239, 4057.2899742544937, 4066.898327541835, 4582.762654083379, 4592.357070010201, 4599.0, 4603.930941035887, 4609.7695115244105, 5383.78464861409, 5414.3502779665905, 5418.322709661293, 5419.972900135474, 5444.891102177934, 1283.7560863435917, 1297.2605614799663, 1330.4279159961116, 1331.4274861809322, 1378.1386633354155, 879.3624622148891, 897.9506127162938, 905.8595917632778, 906.4833045164193, 912.6075787411344, 4613.377194078824, 4627.699199552018, 4635.675502714845, 4639.304104384302, 4663.0, 4888.633352498577, 4918.311436398907, 4918.311436398907, 5233.581313494911, 5646.322441307069, 5250.422453530108, 5256.684598924076, 5265.631405801557, 5273.393559740679, 5329.333833270841, 2913.3393965439495, 2944.2344990302677, 2956.926076848096, 2963.5110206816066, 2963.5702823090533, 5489.533389661844, 5717.256236847718, 5757.971210144006, 5764.913526297109, 5775.653460792366, 5627.606067575312, 5645.887082258332, 5664.716764161775, 5674.432556744293, 5677.290338707661, 5486.259354987025, 5748.396418376094, 5753.59724819267, 5799.391063938226, 5817.3019237690905, 5527.281453411031, 5532.889342213214, 5535.280413546374, 5546.278983732089, 5554.75003624846, 5500.9174862377895, 5507.807226747205, 5508.5402368371615, 5534.667919924656, 5563.721813909369, 5411.511834245614, 5667.773289068391, 5687.0, 5805.506531944832, 5809.76760929575, 3967.2263908537557, 3973.145773658677, 4008.579099194543, 4036.0515278908847, 4040.7777572232635, 5613.382527922007, 5615.382307946041, 5644.915326270191, 5649.514213745939, 5652.152177173457, 5270.762815673227, 5410.567154627542, 5436.55931178246, 5456.7544460498575, 5505.642133261325, 5369.597280204079, 5377.435369286169, 5385.299911011543, 5386.272853164773, 5420.186971954238, 5183.885464625124, 5286.497782710637, 5299.602529810202, 5305.763484274512, 5315.202719592092, 5085.516875896784, 5402.0, 5446.918296225481, 5450.209719590716, 5484.369297530835, 5231.267622532772, 5329.866753331198, 5333.7333133343955, 5335.493128152819, 5346.304980352529], "value": 4119.618947893781, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.8805597076486, 729.325374029023, 753.0232396843245, 762.2073044034205, 872.9432586881852, 14897.627559311022, 14970.0, 15035.09789412636, 15617.984830985977, 16638.916805415985, 15152.924235378836, 15752.369905203777, 15840.76238856418, 15880.126593037377, 15906.204689765495, 798.1061211443192, 824.4270232188601, 826.5495305058728, 826.9007719073719, 826.9751907442786, 673.9595624262536, 690.4579904774753, 793.2345286798238, 803.1927912447982, 804.9114597394282, 862.8101817600118, 865.6840253307561, 866.6446756829702, 866.7876370289288, 866.9176428239307, 856.3235044314983, 856.7130011446174, 856.9871451928195, 857.6140736668524, 857.6655104509247, 514.6114683413998, 522.9555487783543, 614.9815505534841, 620.5625034350771, 629.6914511889187, 15164.469243576423, 15247.23763811816, 15266.3130159142, 15304.617384565476, 15308.846911530853, 13891.0, 14200.431982720678, 14567.344469498898, 14589.562313130624, 14613.0, 13059.869401306056, 13219.0, 13246.602601921957, 13405.66485837852, 14140.151590904476, 4409.955900440987, 4436.511983681792, 4449.71076880005, 4451.332300154971, 4513.0, 77148.61425692835, 77344.61327693381, 79575.60212198959, 80054.19945800584, 80558.0, 10276.229282803819, 11233.0, 11326.0, 11441.427928603536, 11874.1094417919, 20813.58372832535, 20845.58308833815, 20852.791472085388, 20854.165833366496, 20868.582628347347, 7905.841883162305, 8048.476849004796, 8072.313853322534, 8223.835523289501, 8286.295664868554, 4488.977555112204, 4611.377464042378, 4659.184642687516, 4670.719756814602, 4781.187198176319, 3309.3546758381885, 3388.0513456232293, 3418.4872269159328, 3425.828708564562, 3428.160100775326, 599.5713065158345, 607.7389416959826, 610.6732897899602, 619.0590302739811, 636.8694417644465, 654.6955665615417, 661.4741280681869, 671.5701950751522, 691.1222747111141, 695.8817001109824, 9301.953490232505, 9381.0, 9423.246140308896, 9424.811503769886, 9447.905520944703, 691.3155975584236, 698.8742026435189, 709.8899670551073, 727.2908913808994, 746.5334166146158, 3652.6712595866497, 3986.681065514752, 4429.2027435062, 4443.488998765119, 4461.754603496839, 76651.61674191593, 84987.15012849915, 125242.39384821123, 126411.0, 127420.36289818492, 104381.47809260905, 105071.47464262783, 105720.47139764253, 106708.0, 109400.0, 74549.62725186339, 91468.54265728629, 91599.0, 91604.54197729102, 92211.53894230486, 8856.911430885608, 8942.418742781958, 9023.548822558978, 9143.908560914571, 9152.084791520794, 52958.73520632372, 53266.46733532615, 53269.46730532645, 54254.13315069214, 54811.45188548064, 73530.63234683793, 76424.0, 80273.5986320088, 80870.59564702139, 82807.0, 11529.289684004883, 11551.107507573259, 11631.069514438994, 11647.359395233343, 12070.939645301718, 13047.673808154872, 13082.149660272053, 13111.344432778515, 13135.343232838512, 13814.102083364549, 11902.226355286879, 12198.939005304917, 12200.267983920992, 12475.438605262967, 13153.120013520955, 10831.51258193399, 13574.457021719021, 13682.657933551742, 13767.586972390844, 13984.790228146383, 13788.379522921292, 13880.861191387958, 13998.230097344744, 14169.504067357593, 14538.273086345429, 10725.0, 10743.301685390425, 10863.348199108079, 11057.889421105687, 12526.123171377916, 11494.655160345203, 11649.34026389451, 11704.239224450383, 11810.468528916048, 12054.457549410123], "value": 7505.893604839343, "unit": "score"}], "name": "dromaeo_css", "value": 7157.771345979238, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 111.0, 111.0, 112.0, 111.0, 112.0, 111.0, 109.0, 113.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 121.0, 157.0, 123.0, 122.0, 120.0, 121.0, 155.0, 119.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 160.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 115.0, 76.0, 75.0, 75.0, 76.0, 99.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 129.0, 83.0, 83.0, 82.0, 108.0, 82.0, 83.0, 111.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 146.0, 145.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 62.0, 61.0, 60.0, 60.0, 60.0, 59.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 80.0, 88.0, 83.0, 80.0, 80.0, 81.0, 80.0, 80.0, 79.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 147.0, 130.0, 132.0, 131.0, 136.0, 144.0, 147.0, 172.0, 136.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 174.0, 168.0, 171.0, 167.0, 170.0, 172.0, 171.0, 169.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1497.7, "alertThreshold": 2.0}]} 10:52:43 INFO - Return code: 0 10:52:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:52:43 INFO - # TBPL SUCCESS # 10:52:43 INFO - Running post-action listener: _resource_record_post_action 10:52:43 INFO - [mozharness: 2016-10-17 17:52:43.896884Z] Finished run-tests step (success) 10:52:43 INFO - Running post-run listener: _resource_record_post_run 10:52:43 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7860224; Write bytes: 431386624; Read time: 2692; Write time: 405992 10:52:43 INFO - TinderboxPrint: CPU usage
13.1% 10:52:43 INFO - TinderboxPrint: I/O read bytes / time
7,860,224 / 2,692 10:52:43 INFO - TinderboxPrint: I/O write bytes / time
431,386,624 / 405,992 10:52:43 INFO - TinderboxPrint: CPU idle
8,336.2 (86.9%) 10:52:43 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 10:52:43 INFO - TinderboxPrint: Swap in / out
0 / 0 10:52:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1204224; Read time: 0; Write time: 112 10:52:43 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5648384; Write bytes: 430182400; Read time: 2488; Write time: 405880 10:52:44 INFO - Running post-run listener: _upload_blobber_files 10:52:44 INFO - Blob upload gear active. 10:52:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:52:44 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 10:52:44 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:52:44 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:52:44 INFO - (blobuploader) - INFO - Open directory for files ... 10:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:49 INFO - (blobuploader) - INFO - Done attempting. 10:52:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:52:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:52:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:50 INFO - (blobuploader) - INFO - Done attempting. 10:52:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:52:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:52 INFO - (blobuploader) - INFO - Done attempting. 10:52:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:52:52 INFO - Return code: 0 10:52:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:52:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:52:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a356b8e6dd78bb0e21677145bc6c356d5d09959ab15fb0b979fbce00756454432ae639094c569f0f1897579f1cc4c785bbe5c4dfecb9493ab7ce11e44f74c7db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e18cd409b168cf1be251f91e70d77693e28be828cb52b2729974658e2018fb62240c6749730c947b66d473b83e10715c73e671617aa8f1753144574fb177a3ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/497a9638d6641eb59c6c68d539ff3dd0a83b9584f4c83ac1e12075c45e8fa22f88455f0e7ee48fbf1e75cc614d7da955438b2655876134aefe8d862a387cd22a"} 10:52:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:52:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:52:52 INFO - Contents: 10:52:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a356b8e6dd78bb0e21677145bc6c356d5d09959ab15fb0b979fbce00756454432ae639094c569f0f1897579f1cc4c785bbe5c4dfecb9493ab7ce11e44f74c7db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e18cd409b168cf1be251f91e70d77693e28be828cb52b2729974658e2018fb62240c6749730c947b66d473b83e10715c73e671617aa8f1753144574fb177a3ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/497a9638d6641eb59c6c68d539ff3dd0a83b9584f4c83ac1e12075c45e8fa22f88455f0e7ee48fbf1e75cc614d7da955438b2655876134aefe8d862a387cd22a"} 10:52:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:52:52 INFO - Copying logs to upload dir... 10:52:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:52:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.307183 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-17 10:52:52.419380) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 10:52:52.422795) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830 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/sha512/a356b8e6dd78bb0e21677145bc6c356d5d09959ab15fb0b979fbce00756454432ae639094c569f0f1897579f1cc4c785bbe5c4dfecb9493ab7ce11e44f74c7db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e18cd409b168cf1be251f91e70d77693e28be828cb52b2729974658e2018fb62240c6749730c947b66d473b83e10715c73e671617aa8f1753144574fb177a3ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/497a9638d6641eb59c6c68d539ff3dd0a83b9584f4c83ac1e12075c45e8fa22f88455f0e7ee48fbf1e75cc614d7da955438b2655876134aefe8d862a387cd22a"} build_url:https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/alOhuKsfRS-oJy7f7L8-ew/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/sha512/a356b8e6dd78bb0e21677145bc6c356d5d09959ab15fb0b979fbce00756454432ae639094c569f0f1897579f1cc4c785bbe5c4dfecb9493ab7ce11e44f74c7db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e18cd409b168cf1be251f91e70d77693e28be828cb52b2729974658e2018fb62240c6749730c947b66d473b83e10715c73e671617aa8f1753144574fb177a3ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/497a9638d6641eb59c6c68d539ff3dd0a83b9584f4c83ac1e12075c45e8fa22f88455f0e7ee48fbf1e75cc614d7da955438b2655876134aefe8d862a387cd22a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 10:52:52.448830) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:52:52.449362) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476725519.595812-771949830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:52:52.532466) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 10:52:52.532860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 10:52:52.533226) ========= ========= Total master_lag: 0.15 =========