builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1476271258.99 results: success (0) buildid: 20161012030146 builduid: 218056a61d7349029419562c9d163dc7 revision: 500baee3ce9f1b701ace9d38489cbc112d076c72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 04:20:58.986974) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 04:20:58.987453) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 04:20:58.987726) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 04:20:59.002243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:20:59.002506) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 04:20:59-- 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% 32.3M=0s 2016-10-12 04:21:00 (32.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.218792 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:20:59.235923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:20:59.236211) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018049 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:20:59.286048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:20:59.286350) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 500baee3ce9f1b701ace9d38489cbc112d076c72 --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 500baee3ce9f1b701ace9d38489cbc112d076c72 --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=5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 04:21:00,192 truncating revision to first 12 chars 2016-10-12 04:21:00,192 Setting DEBUG logging. 2016-10-12 04:21:00,192 attempt 1/10 2016-10-12 04:21:00,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/500baee3ce9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 04:21:00,507 unpacking tar archive at: mozilla-central-500baee3ce9f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.732650 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:21:00.031902) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 04:21:00.032211) ========= script_repo_revision: 500baee3ce9f1b701ace9d38489cbc112d076c72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 04:21:00.032589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 04:21:00.032850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 04:21:00.042820) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-12 04:21:00.043085) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:21:01 INFO - MultiFileLogger online at 20161012 04:21:01 in /builds/slave/test 04:21:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:21:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:21:01 INFO - {'append_to_log': False, 04:21:01 INFO - 'base_work_dir': '/builds/slave/test', 04:21:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:21:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:21:01 INFO - 'branch': 'Firefox-Non-PGO', 04:21:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:21:01 INFO - 'config_files': ('talos/linux_config.py',), 04:21:01 INFO - 'default_actions': ('clobber', 04:21:01 INFO - 'read-buildbot-config', 04:21:01 INFO - 'download-and-extract', 04:21:01 INFO - 'populate-webroot', 04:21:01 INFO - 'create-virtualenv', 04:21:01 INFO - 'install', 04:21:01 INFO - 'run-tests'), 04:21:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:21:01 INFO - 'download_minidump_stackwalk': True, 04:21:01 INFO - 'download_symbols': 'ondemand', 04:21:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:21:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:21:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:21:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:21:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:21:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:21:01 INFO - 'installer_path': 'installer.exe', 04:21:01 INFO - 'log_level': 'info', 04:21:01 INFO - 'log_name': 'talos', 04:21:01 INFO - 'log_to_console': True, 04:21:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:21:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:21:01 INFO - 'opt_config_files': (), 04:21:01 INFO - 'pip_index': False, 04:21:01 INFO - 'sps_profile': False, 04:21:01 INFO - 'sps_profile_interval': 0, 04:21:01 INFO - 'suite': 'dromaeojs', 04:21:01 INFO - 'system_bits': '32', 04:21:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:21:01 INFO - 'title': 'talos-linux64-ix-051', 04:21:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:21:01 INFO - 'use_talos_json': True, 04:21:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:21:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:21:01 INFO - 'work_dir': 'build'} 04:21:01 INFO - [mozharness: 2016-10-12 11:21:01.047822Z] Running clobber step. 04:21:01 INFO - Running pre-action listener: _resource_record_pre_action 04:21:01 INFO - Running main action method: clobber 04:21:01 INFO - rmtree: /builds/slave/test/build 04:21:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:21:02 INFO - Running post-action listener: _resource_record_post_action 04:21:02 INFO - [mozharness: 2016-10-12 11:21:02.015641Z] Finished clobber step (success) 04:21:02 INFO - [mozharness: 2016-10-12 11:21:02.015739Z] Running read-buildbot-config step. 04:21:02 INFO - Running pre-action listener: _resource_record_pre_action 04:21:02 INFO - Running main action method: read_buildbot_config 04:21:02 INFO - Using buildbot properties: 04:21:02 INFO - { 04:21:02 INFO - "project": "", 04:21:02 INFO - "product": "firefox", 04:21:02 INFO - "script_repo_revision": "production", 04:21:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:21:02 INFO - "repository": "", 04:21:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:21:02 INFO - "buildid": "20161012030146", 04:21:02 INFO - "pgo_build": "False", 04:21:02 INFO - "basedir": "/builds/slave/test", 04:21:02 INFO - "buildnumber": 243, 04:21:02 INFO - "slavename": "talos-linux64-ix-051", 04:21:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:21:02 INFO - "platform": "ubuntu64_hw", 04:21:02 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:21:02 INFO - "branch": "mozilla-central", 04:21:02 INFO - "repo_path": "mozilla-central", 04:21:02 INFO - "revision": "500baee3ce9f1b701ace9d38489cbc112d076c72", 04:21:02 INFO - "stage_platform": "linux64", 04:21:02 INFO - "builduid": "218056a61d7349029419562c9d163dc7", 04:21:02 INFO - "slavebuilddir": "test" 04:21:02 INFO - } 04:21:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:21:02 INFO - Running post-action listener: _resource_record_post_action 04:21:02 INFO - [mozharness: 2016-10-12 11:21:02.018140Z] Finished read-buildbot-config step (success) 04:21:02 INFO - [mozharness: 2016-10-12 11:21:02.018228Z] Running download-and-extract step. 04:21:02 INFO - Running pre-action listener: _resource_record_pre_action 04:21:02 INFO - Running main action method: download_and_extract 04:21:02 INFO - mkdir: /builds/slave/test/build/tests 04:21: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')]} 04:21:02 INFO - trying https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:21:02 INFO - Downloading https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/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 04:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/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 04:21:02 INFO - Downloaded 1361 bytes. 04:21:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:21:02 INFO - Using the following test package requirements: 04:21:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:21:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:21:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:21:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:02 INFO - u'jsshell-linux-x86_64.zip'], 04:21:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:21:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:21:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:21:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:21:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:21:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:21:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:21:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:21:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:21:02 INFO - Fetch https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:21:03 INFO - Http code: 200 04:21:03 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 04:21:03 INFO - x-amz-cf-id: oQpgVnYmURsx782j9gNXfHx9EWRi8vXiZ53mE0WXJ665bsgJtmg2xA== 04:21:03 INFO - x-amz-version-id: zELVbuxUAldU7bKITzMI2y8ssdUG5omr 04:21:03 INFO - Expected file size: 20528383 04:21:03 INFO - Obtained file size: 20528383 04:21:07 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 04:21:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:21:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:21:07 INFO - Fetch https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:21:08 INFO - Http code: 200 04:21:08 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 04:21:08 INFO - x-amz-cf-id: ZX7fJLRd9-Elf2AWdzJlW_a4ut4TkvcwQPc_7PvCoQOFF1bhQg_fcA== 04:21:08 INFO - x-amz-version-id: zELVbuxUAldU7bKITzMI2y8ssdUG5omr 04:21:08 INFO - Expected file size: 20528383 04:21:08 INFO - Obtained file size: 20528383 04:21:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:21:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:21:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:21:13 INFO - Http code: 200 04:21:13 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 04:21:13 INFO - x-amz-cf-id: QdfTQPv7L3srvwsp_8Yd4W6LaWVZicjGDcZmvEn6PfEA1Z0_6abkfQ== 04:21:13 INFO - x-amz-version-id: Oc2put3.wJVluHv793wz75y4Ifd7yihc 04:21:13 INFO - Expected file size: 14409006 04:21:13 INFO - Obtained file size: 14409006 04:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:13 INFO - trying https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:21:13 INFO - Downloading https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/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 04:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/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 04:21:15 INFO - Downloaded 55908830 bytes. 04:21:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:21:15 INFO - mkdir: /builds/slave/test/properties 04:21:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:21:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:21:15 INFO - Contents: 04:21:15 INFO - build_url:https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:21:16 INFO - Running post-action listener: _resource_record_post_action 04:21:16 INFO - Running post-action listener: set_extra_try_arguments 04:21:16 INFO - [mozharness: 2016-10-12 11:21:16.390249Z] Finished download-and-extract step (success) 04:21:16 INFO - [mozharness: 2016-10-12 11:21:16.390473Z] Running populate-webroot step. 04:21:16 INFO - Running pre-action listener: _resource_record_pre_action 04:21:16 INFO - Running main action method: populate_webroot 04:21:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:21:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:21:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:21:16 INFO - '--tppagecycles', 04:21:16 INFO - '7'], 04:21:16 INFO - 'tests': ['tsvgm']}}, 04:21:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:21:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:21:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:21:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:21:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:16 INFO - 'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:16 INFO - 'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['damp', 'tps']}, 04:21:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:16 INFO - 'tests': ['damp', 'tps']}, 04:21:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['dromaeo_dom']}, 04:21:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:21:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['basic_compositor_video']}, 04:21:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:21:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['a11yr', 04:21:16 INFO - 'ts_paint', 04:21:16 INFO - 'tpaint', 04:21:16 INFO - 'sessionrestore', 04:21:16 INFO - 'sessionrestore_no_auto_restore', 04:21:16 INFO - 'tabpaint']}, 04:21:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:21:16 INFO - 'ts_paint', 04:21:16 INFO - 'tpaint', 04:21:16 INFO - 'sessionrestore', 04:21:16 INFO - 'sessionrestore_no_auto_restore', 04:21:16 INFO - 'tabpaint']}, 04:21:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:21:16 INFO - 'ts_paint', 04:21:16 INFO - 'tpaint', 04:21:16 INFO - 'sessionrestore', 04:21:16 INFO - 'sessionrestore_no_auto_restore', 04:21:16 INFO - 'tabpaint']}, 04:21:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:21:16 INFO - 'ts_paint', 04:21:16 INFO - 'tpaint', 04:21:16 INFO - 'sessionrestore', 04:21:16 INFO - 'sessionrestore_no_auto_restore', 04:21:16 INFO - 'tabpaint']}, 04:21:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['a11yr', 04:21:16 INFO - 'ts_paint', 04:21:16 INFO - 'tpaint', 04:21:16 INFO - 'sessionrestore', 04:21:16 INFO - 'sessionrestore_no_auto_restore', 04:21:16 INFO - 'tabpaint']}, 04:21:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['a11yr', 04:21:16 INFO - 'ts_paint', 04:21:16 INFO - 'tpaint', 04:21:16 INFO - 'sessionrestore', 04:21:16 INFO - 'sessionrestore_no_auto_restore', 04:21:16 INFO - 'tabpaint']}, 04:21:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['tsvgx', 04:21:16 INFO - 'tsvgr_opacity', 04:21:16 INFO - 'tart', 04:21:16 INFO - 'tscrollx', 04:21:16 INFO - 'cart']}, 04:21:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:21:16 INFO - 'tsvgr_opacity', 04:21:16 INFO - 'tart', 04:21:16 INFO - 'tscrollx', 04:21:16 INFO - 'cart']}, 04:21:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:16 INFO - 'talos_options': ['--disable-e10s'], 04:21:16 INFO - 'tests': ['tp5o']}, 04:21:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:16 INFO - 'tests': ['tp5o']}, 04:21:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:16 INFO - 'talos_options': ['--disable-e10s', 04:21:16 INFO - '--xperf_path', 04:21:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:16 INFO - 'tests': ['tp5n']}, 04:21:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:21:16 INFO - 'talos_options': ['--xperf_path', 04:21:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:16 INFO - 'tests': ['tp5n']}}, 04:21:16 INFO - 'talos.zip': {'path': '', 04:21:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:21:16 INFO - Running post-action listener: _resource_record_post_action 04:21:16 INFO - [mozharness: 2016-10-12 11:21:16.411752Z] Finished populate-webroot step (success) 04:21:16 INFO - [mozharness: 2016-10-12 11:21:16.411840Z] Running create-virtualenv step. 04:21:16 INFO - Running pre-action listener: _resource_record_pre_action 04:21:16 INFO - Running main action method: create_virtualenv 04:21:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:21: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 04:21:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:21:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:21:16 INFO - Using real prefix '/usr' 04:21:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:21:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:21:18 INFO - Installing pip.................done. 04:21:18 INFO - Return code: 0 04:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:21:19 INFO - Reading from file tmpfile_stdout 04:21:19 INFO - Output received: 04:21:19 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) 04:21:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:21:19 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')]} 04:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:19 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')]} 04:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:19 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 0x7febfa4c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', '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 04:21:19 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 04:21:19 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 04:21:19 INFO - Using env: {'DISPLAY': ':0', 04:21:19 INFO - 'HOME': '/home/cltbld', 04:21:19 INFO - 'LANG': 'en_US.UTF-8', 04:21:19 INFO - 'LANGUAGE': 'en_US:en', 04:21:19 INFO - 'LOGNAME': 'cltbld', 04:21:19 INFO - 'MAIL': '/var/mail/cltbld', 04:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:19 INFO - 'MOZ_NO_REMOTE': '1', 04:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:19 INFO - 'NO_EM_RESTART': '1', 04:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:19 INFO - 'PWD': '/builds/slave/test', 04:21:19 INFO - 'SHELL': '/bin/bash', 04:21:19 INFO - 'SHLVL': '1', 04:21:19 INFO - 'TERM': 'linux', 04:21:19 INFO - 'TMOUT': '86400', 04:21:19 INFO - 'USER': 'cltbld', 04:21:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:19 INFO - '_': '/tools/buildbot/bin/python'} 04:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:19 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 04:21:19 INFO - Cleaning up... 04:21:19 INFO - Return code: 0 04:21:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:21:19 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')]} 04:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:19 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')]} 04:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:19 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 0x7febfa4c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', '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 04:21:19 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 04:21:19 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 04:21:19 INFO - Using env: {'DISPLAY': ':0', 04:21:19 INFO - 'HOME': '/home/cltbld', 04:21:19 INFO - 'LANG': 'en_US.UTF-8', 04:21:19 INFO - 'LANGUAGE': 'en_US:en', 04:21:19 INFO - 'LOGNAME': 'cltbld', 04:21:19 INFO - 'MAIL': '/var/mail/cltbld', 04:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:19 INFO - 'MOZ_NO_REMOTE': '1', 04:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:19 INFO - 'NO_EM_RESTART': '1', 04:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:19 INFO - 'PWD': '/builds/slave/test', 04:21:19 INFO - 'SHELL': '/bin/bash', 04:21:19 INFO - 'SHLVL': '1', 04:21:19 INFO - 'TERM': 'linux', 04:21:19 INFO - 'TMOUT': '86400', 04:21:19 INFO - 'USER': 'cltbld', 04:21:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:19 INFO - '_': '/tools/buildbot/bin/python'} 04:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:19 INFO - Downloading/unpacking psutil>=3.1.1 04:21:19 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 04:21:19 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 04:21:19 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 04:21:19 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 04:21:19 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 04:21:19 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 04:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:21:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:21 INFO - Installing collected packages: psutil 04:21:21 INFO - Running setup.py install for psutil 04:21:21 INFO - building 'psutil._psutil_linux' extension 04:21:21 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 04:21:21 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 04:21:21 INFO - building 'psutil._psutil_posix' extension 04:21:21 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 04:21:22 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 04:21:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:22 INFO - Successfully installed psutil 04:21:22 INFO - Cleaning up... 04:21:22 INFO - Return code: 0 04:21:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:21:22 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')]} 04:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:22 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')]} 04:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:22 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 0x7febfa4c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', '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 04:21:22 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 04:21:22 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 04:21:22 INFO - Using env: {'DISPLAY': ':0', 04:21:22 INFO - 'HOME': '/home/cltbld', 04:21:22 INFO - 'LANG': 'en_US.UTF-8', 04:21:22 INFO - 'LANGUAGE': 'en_US:en', 04:21:22 INFO - 'LOGNAME': 'cltbld', 04:21:22 INFO - 'MAIL': '/var/mail/cltbld', 04:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:22 INFO - 'MOZ_NO_REMOTE': '1', 04:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:22 INFO - 'NO_EM_RESTART': '1', 04:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:22 INFO - 'PWD': '/builds/slave/test', 04:21:22 INFO - 'SHELL': '/bin/bash', 04:21:22 INFO - 'SHLVL': '1', 04:21:22 INFO - 'TERM': 'linux', 04:21:22 INFO - 'TMOUT': '86400', 04:21:22 INFO - 'USER': 'cltbld', 04:21:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:22 INFO - '_': '/tools/buildbot/bin/python'} 04:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:21:22 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 04:21:22 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 04:21:22 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 04:21:22 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 04:21:22 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 04:21:22 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 04:21:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:21:24 INFO - Installing collected packages: mozsystemmonitor 04:21:24 INFO - Running setup.py install for mozsystemmonitor 04:21:24 INFO - Successfully installed mozsystemmonitor 04:21:24 INFO - Cleaning up... 04:21:24 INFO - Return code: 0 04:21:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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', '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 0x7febfa4c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', '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 04:21: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:21: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 jsonschema==2.5.1 04:21:24 INFO - Using env: {'DISPLAY': ':0', 04:21:24 INFO - 'HOME': '/home/cltbld', 04:21:24 INFO - 'LANG': 'en_US.UTF-8', 04:21:24 INFO - 'LANGUAGE': 'en_US:en', 04:21:24 INFO - 'LOGNAME': 'cltbld', 04:21:24 INFO - 'MAIL': '/var/mail/cltbld', 04:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:24 INFO - 'MOZ_NO_REMOTE': '1', 04:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:24 INFO - 'NO_EM_RESTART': '1', 04:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:24 INFO - 'PWD': '/builds/slave/test', 04:21:24 INFO - 'SHELL': '/bin/bash', 04:21:24 INFO - 'SHLVL': '1', 04:21:24 INFO - 'TERM': 'linux', 04:21:24 INFO - 'TMOUT': '86400', 04:21:24 INFO - 'USER': 'cltbld', 04:21:24 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:24 INFO - '_': '/tools/buildbot/bin/python'} 04:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:24 INFO - Downloading/unpacking jsonschema==2.5.1 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:26 INFO - warning: no files found matching '*.txt' 04:21:26 INFO - no previously-included directories found matching 'build' 04:21:26 INFO - no previously-included directories found matching 'dist' 04:21:26 INFO - no previously-included directories found matching '.git*' 04:21:26 INFO - Installing collected packages: jsonschema, functools32 04:21:27 INFO - Running setup.py install for functools32 04:21:27 INFO - warning: no files found matching '*.txt' 04:21:27 INFO - no previously-included directories found matching 'build' 04:21:27 INFO - no previously-included directories found matching 'dist' 04:21:27 INFO - no previously-included directories found matching '.git*' 04:21:27 INFO - Successfully installed jsonschema functools32 04:21:27 INFO - Cleaning up... 04:21:27 INFO - Return code: 0 04:21:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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', '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 0x7febfa4c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', '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 04:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:21: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 functools32==3.2.3-2 04:21:27 INFO - Using env: {'DISPLAY': ':0', 04:21:27 INFO - 'HOME': '/home/cltbld', 04:21:27 INFO - 'LANG': 'en_US.UTF-8', 04:21:27 INFO - 'LANGUAGE': 'en_US:en', 04:21:27 INFO - 'LOGNAME': 'cltbld', 04:21:27 INFO - 'MAIL': '/var/mail/cltbld', 04:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:27 INFO - 'MOZ_NO_REMOTE': '1', 04:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:27 INFO - 'NO_EM_RESTART': '1', 04:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:27 INFO - 'PWD': '/builds/slave/test', 04:21:27 INFO - 'SHELL': '/bin/bash', 04:21:27 INFO - 'SHLVL': '1', 04:21:27 INFO - 'TERM': 'linux', 04:21:27 INFO - 'TMOUT': '86400', 04:21:27 INFO - 'USER': 'cltbld', 04:21:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:27 INFO - '_': '/tools/buildbot/bin/python'} 04:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:21:27 INFO - Cleaning up... 04:21:27 INFO - Return code: 0 04:21:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21: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')]} 04:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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')]} 04:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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', '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 0x7febfa4c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', '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 04:21: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:21: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 blobuploader==1.2.4 04:21:27 INFO - Using env: {'DISPLAY': ':0', 04:21:27 INFO - 'HOME': '/home/cltbld', 04:21:27 INFO - 'LANG': 'en_US.UTF-8', 04:21:27 INFO - 'LANGUAGE': 'en_US:en', 04:21:27 INFO - 'LOGNAME': 'cltbld', 04:21:27 INFO - 'MAIL': '/var/mail/cltbld', 04:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:27 INFO - 'MOZ_NO_REMOTE': '1', 04:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:27 INFO - 'NO_EM_RESTART': '1', 04:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:27 INFO - 'PWD': '/builds/slave/test', 04:21:27 INFO - 'SHELL': '/bin/bash', 04:21:27 INFO - 'SHLVL': '1', 04:21:27 INFO - 'TERM': 'linux', 04:21:27 INFO - 'TMOUT': '86400', 04:21:27 INFO - 'USER': 'cltbld', 04:21:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:27 INFO - '_': '/tools/buildbot/bin/python'} 04:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:29 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21: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 04:21:30 INFO - Downloading docopt-0.6.1.tar.gz 04:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:30 INFO - Running setup.py install for blobuploader 04:21:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:30 INFO - Running setup.py install for requests 04:21:30 INFO - Running setup.py install for docopt 04:21:30 INFO - Successfully installed blobuploader requests docopt 04:21:30 INFO - Cleaning up... 04:21:30 INFO - Return code: 0 04:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:30 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')]} 04:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:30 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')]} 04:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:30 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 0x7febfa4c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', '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 04:21:30 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 04:21:30 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 04:21:30 INFO - Using env: {'DISPLAY': ':0', 04:21:30 INFO - 'HOME': '/home/cltbld', 04:21:30 INFO - 'LANG': 'en_US.UTF-8', 04:21:30 INFO - 'LANGUAGE': 'en_US:en', 04:21:30 INFO - 'LOGNAME': 'cltbld', 04:21:30 INFO - 'MAIL': '/var/mail/cltbld', 04:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:30 INFO - 'MOZ_NO_REMOTE': '1', 04:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:30 INFO - 'NO_EM_RESTART': '1', 04:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:30 INFO - 'PWD': '/builds/slave/test', 04:21:30 INFO - 'SHELL': '/bin/bash', 04:21:30 INFO - 'SHLVL': '1', 04:21:30 INFO - 'TERM': 'linux', 04:21:30 INFO - 'TMOUT': '86400', 04:21:30 INFO - 'USER': 'cltbld', 04:21:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:30 INFO - '_': '/tools/buildbot/bin/python'} 04:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:31 INFO - Running setup.py (path:/tmp/pip-Uhv9IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:31 INFO - Running setup.py (path:/tmp/pip-KSVbUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:31 INFO - Running setup.py (path:/tmp/pip-LZ64DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:31 INFO - Running setup.py (path:/tmp/pip-DMyPta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:31 INFO - Running setup.py (path:/tmp/pip-sMguAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:31 INFO - Running setup.py (path:/tmp/pip-Zr6pB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:31 INFO - Running setup.py (path:/tmp/pip-ZHH7wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:31 INFO - Running setup.py (path:/tmp/pip-F2oU66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:31 INFO - Running setup.py (path:/tmp/pip-89nHiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:31 INFO - Running setup.py (path:/tmp/pip-mzMhiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:31 INFO - Running setup.py (path:/tmp/pip-0T5U7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:31 INFO - Running setup.py (path:/tmp/pip-sxBohb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:32 INFO - Running setup.py (path:/tmp/pip-XotJkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:32 INFO - Running setup.py (path:/tmp/pip-SeWrKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:32 INFO - Running setup.py (path:/tmp/pip-VnSEEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:32 INFO - Running setup.py (path:/tmp/pip-tv5OAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:32 INFO - Running setup.py (path:/tmp/pip-lDp6NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:32 INFO - Running setup.py install for manifestparser 04:21:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Running setup.py install for mozcrash 04:21:32 INFO - Running setup.py install for mozdebug 04:21:32 INFO - Running setup.py install for mozdevice 04:21:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Running setup.py install for mozfile 04:21:32 INFO - Running setup.py install for mozhttpd 04:21:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozinfo 04:21:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozInstall 04:21:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozleak 04:21:33 INFO - Running setup.py install for mozlog 04:21:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for moznetwork 04:21:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozprocess 04:21:33 INFO - Running setup.py install for mozprofile 04:21:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozrunner 04:21:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozscreenshot 04:21:33 INFO - Running setup.py install for moztest 04:21:34 INFO - Running setup.py install for mozversion 04:21:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:34 INFO - Cleaning up... 04:21:34 INFO - Return code: 0 04:21:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:34 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')]} 04:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:34 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')]} 04:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:34 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 0x7febfa4c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', '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 04:21:34 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 04:21:34 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 04:21:34 INFO - Using env: {'DISPLAY': ':0', 04:21:34 INFO - 'HOME': '/home/cltbld', 04:21:34 INFO - 'LANG': 'en_US.UTF-8', 04:21:34 INFO - 'LANGUAGE': 'en_US:en', 04:21:34 INFO - 'LOGNAME': 'cltbld', 04:21:34 INFO - 'MAIL': '/var/mail/cltbld', 04:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:34 INFO - 'MOZ_NO_REMOTE': '1', 04:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:34 INFO - 'NO_EM_RESTART': '1', 04:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:34 INFO - 'PWD': '/builds/slave/test', 04:21:34 INFO - 'SHELL': '/bin/bash', 04:21:34 INFO - 'SHLVL': '1', 04:21:34 INFO - 'TERM': 'linux', 04:21:34 INFO - 'TMOUT': '86400', 04:21:34 INFO - 'USER': 'cltbld', 04:21:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:34 INFO - '_': '/tools/buildbot/bin/python'} 04:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:34 INFO - Running setup.py (path:/tmp/pip-mtm9kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:34 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)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:34 INFO - Running setup.py (path:/tmp/pip-qzGGj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:34 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)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:34 INFO - Running setup.py (path:/tmp/pip-kAWCXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:34 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)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:34 INFO - Running setup.py (path:/tmp/pip-ZR_ypM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:34 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)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:34 INFO - Running setup.py (path:/tmp/pip-Q8UpEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:34 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)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:34 INFO - Running setup.py (path:/tmp/pip-ijtpSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:34 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)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:34 INFO - Running setup.py (path:/tmp/pip-qJIw8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:34 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)) 04:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:34 INFO - Running setup.py (path:/tmp/pip-AY8Q3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:35 INFO - Running setup.py (path:/tmp/pip-LPyxDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:35 INFO - Running setup.py (path:/tmp/pip-c6jvsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:35 INFO - Running setup.py (path:/tmp/pip-32wrk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:35 INFO - Running setup.py (path:/tmp/pip-r1ddot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:35 INFO - Running setup.py (path:/tmp/pip-gywY8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:35 INFO - Running setup.py (path:/tmp/pip-hm7fwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:35 INFO - Running setup.py (path:/tmp/pip-xIU1mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:35 INFO - Running setup.py (path:/tmp/pip-lQfXYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:35 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)) 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:35 INFO - Running setup.py (path:/tmp/pip-T2IzSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:35 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)) 04:21:35 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)) 04:21:35 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)) 04:21:35 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)) 04:21:35 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)) 04:21:35 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)) 04:21:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:35 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 04:21:35 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 04:21:35 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 04:21:35 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 04:21:35 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 04:21:35 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 04:21:37 INFO - Downloading blessings-1.6.tar.gz 04:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:37 INFO - Installing collected packages: blessings 04:21:37 INFO - Running setup.py install for blessings 04:21:37 INFO - Successfully installed blessings 04:21:37 INFO - Cleaning up... 04:21:37 INFO - Return code: 0 04:21:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:38 INFO - Reading from file tmpfile_stdout 04:21:38 INFO - Current package versions: 04:21:38 INFO - argparse == 1.2.1 04:21:38 INFO - blessings == 1.6 04:21:38 INFO - blobuploader == 1.2.4 04:21:38 INFO - docopt == 0.6.1 04:21:38 INFO - functools32 == 3.2.3-2 04:21:38 INFO - jsonschema == 2.5.1 04:21:38 INFO - manifestparser == 1.1 04:21:38 INFO - mozInstall == 1.12 04:21:38 INFO - mozcrash == 0.17 04:21:38 INFO - mozdebug == 0.1 04:21:38 INFO - mozdevice == 0.48 04:21:38 INFO - mozfile == 1.2 04:21:38 INFO - mozhttpd == 0.7 04:21:38 INFO - mozinfo == 0.9 04:21:38 INFO - mozleak == 0.1 04:21:38 INFO - mozlog == 3.4 04:21:38 INFO - moznetwork == 0.27 04:21:38 INFO - mozprocess == 0.23 04:21:38 INFO - mozprofile == 0.28 04:21:38 INFO - mozrunner == 6.12 04:21:38 INFO - mozscreenshot == 0.1 04:21:38 INFO - mozsystemmonitor == 0.3 04:21:38 INFO - moztest == 0.7 04:21:38 INFO - mozversion == 1.4 04:21:38 INFO - psutil == 3.1.1 04:21:38 INFO - requests == 1.2.3 04:21:38 INFO - wsgiref == 0.1.2 04:21:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:38 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 0x7febfa4c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', '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 04:21:38 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 04:21:38 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 04:21:38 INFO - Using env: {'DISPLAY': ':0', 04:21:38 INFO - 'HOME': '/home/cltbld', 04:21:38 INFO - 'LANG': 'en_US.UTF-8', 04:21:38 INFO - 'LANGUAGE': 'en_US:en', 04:21:38 INFO - 'LOGNAME': 'cltbld', 04:21:38 INFO - 'MAIL': '/var/mail/cltbld', 04:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:38 INFO - 'MOZ_NO_REMOTE': '1', 04:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:38 INFO - 'NO_EM_RESTART': '1', 04:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:38 INFO - 'PWD': '/builds/slave/test', 04:21:38 INFO - 'SHELL': '/bin/bash', 04:21:38 INFO - 'SHLVL': '1', 04:21:38 INFO - 'TERM': 'linux', 04:21:38 INFO - 'TMOUT': '86400', 04:21:38 INFO - 'USER': 'cltbld', 04:21:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:38 INFO - '_': '/tools/buildbot/bin/python'} 04:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:38 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)) 04:21:38 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)) 04:21:38 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)) 04:21:38 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)) 04:21:38 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)) 04:21:38 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)) 04:21:38 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)) 04:21:38 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)) 04:21:38 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)) 04:21:38 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)) 04:21:38 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)) 04:21:38 INFO - Cleaning up... 04:21:38 INFO - Return code: 0 04:21:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:38 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 0x7febfa4c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', '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 04:21:38 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 04:21:38 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 04:21:38 INFO - Using env: {'DISPLAY': ':0', 04:21:38 INFO - 'HOME': '/home/cltbld', 04:21:38 INFO - 'LANG': 'en_US.UTF-8', 04:21:38 INFO - 'LANGUAGE': 'en_US:en', 04:21:38 INFO - 'LOGNAME': 'cltbld', 04:21:38 INFO - 'MAIL': '/var/mail/cltbld', 04:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:38 INFO - 'MOZ_NO_REMOTE': '1', 04:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:38 INFO - 'NO_EM_RESTART': '1', 04:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:38 INFO - 'PWD': '/builds/slave/test', 04:21:38 INFO - 'SHELL': '/bin/bash', 04:21:38 INFO - 'SHLVL': '1', 04:21:38 INFO - 'TERM': 'linux', 04:21:38 INFO - 'TMOUT': '86400', 04:21:38 INFO - 'USER': 'cltbld', 04:21:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:38 INFO - '_': '/tools/buildbot/bin/python'} 04:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:21:38 INFO - Cleaning up... 04:21:38 INFO - Return code: 0 04:21:38 INFO - Running post-action listener: _resource_record_post_action 04:21:38 INFO - Running post-action listener: _start_resource_monitoring 04:21:38 INFO - Starting resource monitoring. 04:21:38 INFO - [mozharness: 2016-10-12 11:21:38.572924Z] Finished create-virtualenv step (success) 04:21:38 INFO - [mozharness: 2016-10-12 11:21:38.573436Z] Running install step. 04:21:38 INFO - Running pre-action listener: _resource_record_pre_action 04:21:38 INFO - Running main action method: install 04:21:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:38 INFO - Reading from file tmpfile_stdout 04:21:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:38 INFO - Reading from file tmpfile_stdout 04:21:38 INFO - Output received: 04:21:38 INFO - Usage: mozinstall [options] installer 04:21:38 INFO - Options: 04:21:38 INFO - -h, --help show this help message and exit 04:21:38 INFO - -d DEST, --destination=DEST 04:21:38 INFO - Directory to install application into. [default: 04:21:38 INFO - "/builds/slave/test"] 04:21:38 INFO - --app=APP Application being installed. [default: firefox] 04:21:38 INFO - mkdir: /builds/slave/test/build/application 04:21:38 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'] 04:21:38 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 04:21:55 INFO - Reading from file tmpfile_stdout 04:21:55 INFO - Output received: 04:21:55 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:55 INFO - Running post-action listener: _resource_record_post_action 04:21:55 INFO - [mozharness: 2016-10-12 11:21:55.026485Z] Finished install step (success) 04:21:55 INFO - [mozharness: 2016-10-12 11:21:55.026727Z] Running run-tests step. 04:21:55 INFO - Running pre-action listener: _resource_record_pre_action 04:21:55 INFO - Running main action method: run_tests 04:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:55 INFO - Python 2.7.3 04:21:55 INFO - Return code: 0 04:21:55 INFO - grabbing minidump binary from tooltool 04:21:55 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')]} 04:21:55 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 0xff5f60>, '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 0xff6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff71d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:55 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 04:21:55 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 04:21:55 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 04:21:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:55 INFO - Return code: 0 04:21:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 04:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 04:21:55 INFO - Using env: {'DISPLAY': ':0', 04:21:55 INFO - 'HOME': '/home/cltbld', 04:21:55 INFO - 'LANG': 'en_US.UTF-8', 04:21:55 INFO - 'LANGUAGE': 'en_US:en', 04:21:55 INFO - 'LOGNAME': 'cltbld', 04:21:55 INFO - 'MAIL': '/var/mail/cltbld', 04:21:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:55 INFO - 'MOZ_NO_REMOTE': '1', 04:21:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:55 INFO - 'NO_EM_RESTART': '1', 04:21:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:55 INFO - 'PWD': '/builds/slave/test', 04:21:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:55 INFO - 'SHELL': '/bin/bash', 04:21:55 INFO - 'SHLVL': '1', 04:21:55 INFO - 'TERM': 'linux', 04:21:55 INFO - 'TMOUT': '86400', 04:21:55 INFO - 'USER': 'cltbld', 04:21:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386', 04:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:55 INFO - '_': '/tools/buildbot/bin/python'} 04:21:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 04:21:55 INFO - mozversion application_buildid: 20161012030146 04:21:55 INFO - mozversion application_changeset: 500baee3ce9f1b701ace9d38489cbc112d076c72 04:21:55 INFO - mozversion application_display_name: Nightly 04:21:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:55 INFO - mozversion application_name: Firefox 04:21:55 INFO - mozversion application_remotingname: firefox 04:21:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:21:55 INFO - mozversion application_vendor: Mozilla 04:21:55 INFO - mozversion application_version: 52.0a1 04:21:55 INFO - mozversion platform_buildid: 20161012030146 04:21:55 INFO - mozversion platform_changeset: 500baee3ce9f1b701ace9d38489cbc112d076c72 04:21:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:21:55 INFO - mozversion platform_version: 52.0a1 04:21:55 INFO - using testdate: 1476271315 04:21:55 INFO - actual date: 1476271315 04:21:55 INFO - starting webserver on 'localhost:55088' 04:21:55 INFO - SUITE-START | Running 2 tests 04:21:55 INFO - TEST-START | dromaeo_css 04:21:55 INFO - operating with platform_type : linux_ 04:21:55 INFO - Initialising browser for dromaeo_css test... 04:21:55 INFO - TEST-INFO | started process 27395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQZSHk1/profile http://localhost:55088/getInfo.html) 04:21:59 INFO - PROCESS | 27395 | __metrics Screen width/height:1600/1200 04:21:59 INFO - PROCESS | 27395 | colorDepth:24 04:21:59 INFO - PROCESS | 27395 | Browser inner width/height: 1024/697 04:21:59 INFO - PROCESS | 27395 | __metrics 04:22:00 INFO - PROCESS | 27395 | 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" 04:22:00 INFO - PROCESS | 27395 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:22:01 INFO - PROCESS | 27395 | console.error: PushService: 04:22:01 INFO - PROCESS | 27395 | stateChangeProcessEnqueue: Error transitioning state 04:22:01 INFO - PROCESS | 27395 | UnknownError 04:22:01 INFO - TEST-INFO | 27395: exit 0 04:22:01 INFO - Browser initialized. 04:22:01 INFO - Running cycle 1/1 for dromaeo_css test... 04:22:01 INFO - TEST-INFO | started process 27479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQZSHk1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:14 INFO - PROCESS | 27479 | RSS: Main: 174718976 04:22:14 INFO - PROCESS | 27479 | 04:23:05 INFO - PROCESS | 27479 | 1476271385810 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] 04:25:18 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55088/tests/dromaeo/cssquery-ext.html) 04:25:19 INFO - PROCESS | 27479 | RSS: Main: 315953152 04:25:19 INFO - PROCESS | 27479 | 04:28:22 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-ext.html (next: http://localhost:55088/tests/dromaeo/cssquery-jquery.html) 04:28:23 INFO - PROCESS | 27479 | RSS: Main: 275918848 04:28:23 INFO - PROCESS | 27479 | 04:31:25 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55088/tests/dromaeo/cssquery-mootools.html) 04:31:26 INFO - PROCESS | 27479 | RSS: Main: 218148864 04:31:26 INFO - PROCESS | 27479 | 04:34:28 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55088/tests/dromaeo/cssquery-prototype.html) 04:34:28 INFO - PROCESS | 27479 | RSS: Main: 220364800 04:34:28 INFO - PROCESS | 27479 | 04:37:32 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55088/tests/dromaeo/cssquery-yui.html) 04:37:32 INFO - PROCESS | 27479 | RSS: Main: 219594752 04:37:32 INFO - PROCESS | 27479 | 04:40:36 INFO - PROCESS | 27479 | Cycle 1(1): loaded http://localhost:55088/tests/dromaeo/cssquery-yui.html (next: http://localhost:55088/tests/dromaeo/cssquery-dojo.html) 04:40:36 INFO - PROCESS | 27479 | RSS: Main: 309628928 04:40:36 INFO - PROCESS | 27479 | 04:40:36 INFO - PROCESS | 27479 | __start_tp_report 04:40:36 INFO - PROCESS | 27479 | _x_x_mozilla_page_load 04:40:36 INFO - PROCESS | 27479 | _x_x_mozilla_page_load_details 04:40:36 INFO - PROCESS | 27479 | |i|pagename|runs| 04:40:36 INFO - PROCESS | 27479 | |0;dojo.html;2533.746625337466;2555.4505781257026;2590.7797837183834;2604.1015849531905;2614.0981361430313;4404.493483249419;4442.755648439334;4497.662675299353;4537.84117555886;4542.227821270384;4469.642428605712;4521.660875434339;4559.566841150094;4571.040081582872;4592.058627981256;4135.855245066423;4153.314703073989;4206.432131662217;4234.047339348653;4256.318988961767;4231.259529582326;4240.745555266679;4278.871633850989;4281.593248641389;4326.242907491192;4103.938440923389;4212.557681443465;4215.199112168709;4313.547077556843;4332.610065094141;4160.895977600554;4163.333866581333;4171.958280417188;4224.894377640584;4229.577042295746;4190.28765109929;4202.159568086395;4203.6637069034405;4261.6803739719335;4269.658427325838;4540.931886021713;4542.591166795004;4569.862904112882;4584.312353147021;4619.076184763061;4694.0611877624615;4742.146413645542;4745.145873742725;4808.062427826575;4933.407991041062;4881.755912204411;4894.5105489451125;4897.1674815281485;4901.485344038896;4953.876153096166;4562.771861406916;4573.382593349922;4575.10785396851;4576.084783043405;4628.5371462853445;4789.137955168103;4838.879028024327;4985.750712464363;4990.600751939836;5043.722595257296;4681.648876334289;4706.623470122382;4716.6698331116495;4727.220008698595;4789;4788.473267940523;4790.089882922233;4794.113089078532;4807.903841923142;4864.902701945941;4758.833440829554;4765.11845308619;4771.5228477152705;4825.469198388175;4829.348038014893;4644.419447569054;4646.442426908725;4694.577488026094;4749.691270067435;4757.595604373598;4055.1281474483126;4060.3909413587608;4060.451839001756;4060.614241647039;4060.675145988373;3568.107973006748;3593.964060359363;3601.135727425399;3612.078919875415;3622.42041273395;4288.5282618912515;4296;4306.4832220133785;4347.065380943112;4356.302991521405;4891.975540122347;4897.314375987365;4897.706137631682;4898.8775280618265;4956.653034287565;4145.91708165835;4201.243776120266;4239.109786944715;4280.743155410685;4284.485861696617;4368.7815609219415;4375.16871794358;4405.31717583775;4424.60178583929;4427;4603.792829322621;4638.1883170445035;4642.698224615322;4645.163870503342;4702.435707715096;4739.289106634033;4745.857624271277;4789.784459699252;4876.707397556158;4886.364772579542;4554.089182163647;4559.498455169863;4566.725996440225;4617.053504031598;4626.583607475343;4766.356541866804;4769.689970151929;4772.976135119302;4775.164346239464;4828.66199366055;4639;4830.855074347775;4838.612910967185;4849.927251091307;4907.803687852446;4574.931376029295;4672.9299060514795;4696.976515117402;4716.504766999416;4789.544993225638;4726.62187025044;4728.621710263102;4731.243001119942;4741.525847415369;4786.904261914812;4643.930341044955;4670.789814458425;4693.9765301173275;4698.483166851575;4757.500462451393;4617.722936623813;4647.674662773574;4668.626509879269;4673.135469938073;4781.282807578891;4598.3792188054185;4607.723536587815;4635.791389387418;4646.372739680235;4649.325847751989 04:40:36 INFO - PROCESS | 27479 | |1;ext.html;568.8435680187949;571.2060236271583;574.5719439017932;579.5508480927281;579.7825815319255;27409.45181096377;37873;39314.213715725666;39323.41014884779;43488;39614;39914.8004259979;39943.20113597734;39978.40032399516;40047.39928901062;7592.468527203098;7759.185285544993;7767.6504557294775;7776.961115194416;7781.8832717509;7581.507202031878;7668;7668.348190403823;7669.0797104347275;7674.53952762836;7659.119201291867;7700.807479812994;7703.037120359955;7721.691132354699;7722.266384693473;7626.618669066552;7661.387089032864;7672.079350477979;7673.079230492321;7674.769756907302;7573.431992600522;7639.9236007639765;7643.770686879402;7651.961740191319;7654.4259180561685;37019.629803701886;37393.813030934674;37415;37533;37533.62466375329;2870.799044066916;3200.1839530919465;3553.9111522211892;3556.590992035897;3650.817459127033;28094.157175284774;28220.576691349645;28333.71666283352;28429.147125586267;29552.113436596937;3487.720982321408;3524.8942531724088;3535.9646403535894;3539.52216450781;3587.7488575799703;256319;256819.71590142118;257239;257544;258159;49931;50102.24028717266;50131;50149.24776128361;50157.24764128541;32248.35503289921;33604.32791344159;33651.495227571606;35602.465963010574;35661.8216908919;13918.443262269397;14017.369218385196;14049.367778449994;14089.85910140906;14109.223992680501;10780.784384312426;10842.457877106113;10849.891501084889;10866.45667716611;10881.238313317992;17550.473485795446;17557.927362711474;17648.205830737646;17655.470335889688;17717.11414429299;6744.426723728538;6842.589444633239;6845.281245469154;6862;7125.42996560274;791.9326857217086;841.7853447370882;869.4870026684287;870.9477431354139;872.1932212703351;26553.468930621664;27121.593176102375;27274.727252727615;27832;27835.860820695765;917.9770505737276;928.7353104365224;946.4132238012477;949.7957939043139;1020.0156848640949;13642.52251171224;14324.212168330841;14515.419383224764;14584.56246312591;14681.559553213421;345925;349818;350575;351788;352574;49340.75329623329;49967;49988.75005624948;50035.49964500308;50090.499095008585;1059.8357254625546;1102.9558817647205;1103.1175059952166;1145.954161833534;1178.1458442629196;20540.897295513427;27967.72032279651;28784.42431151407;30519.847400762854;30842.38315233638;45129.548704512534;45214.32178517259;47125.52874471348;47198.76400617975;52216.73891630518;382110;386897;387002;387196;387447;29634.259143521584;30035.19788812591;37328.44007339838;37415;37934.62065379311;30498.085057448312;39648;40102.39846402248;40225.597744023355;40489.79755101324;33697.494537582446;34044;34123;34747.30505389928;35437.64562354344;34239.82880085584;34644;34733.65266347405;35118;35119.29761404809;30310.242243944078;30970.380592388476;34201.144971375914;34705.13237169091;38330.42504362493;30027;33027;33127.66872331342;33144.66855331416;33216.1695957603;23926.162584309466;24903.750962490143;25061.373465663506;25272.494550109262;25381.492370152126 04:40:36 INFO - PROCESS | 27479 | |2;jquery.html;339.13689659815765;345.5414724237053;349.3676445633403;352.6984428313791;373.10268803527526;12036.518539258419;13086.411111499981;16024.599385015366;16923.91538042311;17219.741703874453;15821;16897.66204675906;16914.74627880583;17067;17107.31570737169;4429.77851107445;4634.513376095495;5004.7497625118685;5243.449437809032;5246.422893481714;5033.874153146164;5194.740262986855;5202.115640341132;5203.583713302945;5205.843824685266;4990.201567749161;5053.418856831475;5107.948920510803;5130.9230361544605;5137.48625137487;5058.266551350052;5135.3067335909545;5142.485751424865;5142.768575414097;5153.922691159635;4589.105124500724;4599.333096700993;4603.792829322689;4606.516315786861;6044.24446944132;21872;22009.559808803893;22460.213892513846;22600.66099008516;22680.773192268196;1960.8725432846961;2065.979340206594;2166.5450255446376;2208.1277895231456;2516.4086439686657;13532.917366610647;14282.500112496013;14333.49832755859;14736.115833050051;15024.248787560688;1783.3134243316288;1890.3478299986482;1895.4313705888178;1938.5557759469286;1968.3307675390436;72936;75981;76221;78906.60546697288;80628.59685701593;15539.378424863105;15907.443239486562;16122.435714750161;16179.822456813707;16761.7485737714;28227.15318540447;28286.434271314458;28332.71667283301;28469.00358487443;28493.145205643865;8495.95752021236;8763;8846.380753347205;9040.457572545536;9192.95403522978;7135.393491553276;7314.622747607049;7322.743703970335;7441.813954651068;7531;8011.479253848481;8187.4268801184535;8260.586970651564;8425.578721063923;8448.619812108469;3172.397244523533;3380.695737383647;3422.401079811023;3422.760406771502;3530.099824544776;751.8082888863414;825.529448214512;825.6243409248777;831.1522247307712;945;16199.75700364472;16566.17169141538;16673.74989375136;16745.91627041857;17489.475315740547;811.6834434570522;845.3237410071918;856.2550580994574;884.5311984648147;886.7650072730731;8547.91399117524;9527.761805954768;9585.808283834283;9593.520323983774;9607.51962401877;388206;390630;394414.02792986424;396365;399185;69823.30176698168;70856.93714594285;71566.64216678884;74347.62826185835;74490.88263676049;905.2486436258022;926.4580220570907;946.9337146399823;949.8147861167145;952.9190018848337;14247.786283205967;14361.856381436051;14633.268336582916;14714.77927831062;15146.545603631468;33754.31228438519;33978.490322644684;34413.31173376569;34697.826510867286;35531.249062678005;46812;47002.76498617485;47267.29099063448;47698;48063.279050813566;6490.513211509061;6494.740210391531;6629.3039230882;6734.764283250062;6869.519133660596;9293.581788819654;9652.613895444103;9882.752931176778;9987.350822196535;10012.749681258027;8872.911270887209;8957.641694332415;8983.730488085368;9029.41308814925;9196.54017299119;8666.263367613823;8848.734537963872;9075.863862041942;9083.091690831128;9174.587143578421;8966.148215919477;9026.85164911723;9098.226650734761;9331.440113593206;9554.761130971781;6301.40136687014;6423.197100362455;6522.902156467751;6618.07346971434;6860.656967151523;6478.449331806661;8145.511269323622;8453.746387608382;8731.956340218258;8882.067382924959 04:40:36 INFO - PROCESS | 27479 | |3;mootools.html;1231.9137660363779;1340.8592097829728;1365.4947669362336;1426.728921504914;1657.3453485873074;6331;7155.248698886614;7395.334419902208;7447.106347238339;7693.538387696742;7502.774916752506;7587.430942679293;7591.8861217081785;7593.468457207998;7603.125640551324;2096.486360841592;2102.106604693007;2130.052126803573;2130.541933484308;2133.4026472587702;2066.9689954650694;2105.652567326397;2122.0875023739786;2122.596706625744;2125.6280150973594;2065.648839697255;2091.6967039779224;2096.6330892093897;2102.7686954435;2134.658454647257;2057.77364489906;2062.3297428335777;2062.979370206309;2064.370367038053;2065.3390914907236;2046.31448464763;2061.3403710812545;2094.790520947908;2097.370788763365;2101.9474513137293;7408.073990751156;7450.776476705708;7459.477836551444;7468.47720659554;7477.401807855358;4103.4050062741035;4247.766372849492;4248.383984322287;4291.35629655551;4298.548652391485;2570.370259286468;2697.447023360226;2758.7379198976264;2760.1167626359575;2764.3089227693076;897.8428774964356;912.5163663258484;917.1837065012145;922.7001224601964;926.1063074133426;9966.750831229205;10002.949690282489;10068.093871551522;10077.546510406975;10122.089011988883;3607.4408466687705;3745.344564701221;3840.635139661728;3855.3445914194654;3865.845366185321;7946.4834785739895;7955.761327160194;7973.2824045835;7973.840523189504;7981.600919953979;4147.8963025924595;4155.10665206982;4157.085441202991;4157.459530261047;4168.166366726606;3311.1556553079295;3413.7098346640814;3724.1620635356826;3779.093017675738;3820.8662696805477;3123.6720144384512;3155.7475401967786;3239.400710868497;3242.7243684286627;3282.9343413132083;991.5884907763198;1004.6785028790716;1005.2762011351815;1007.2093406675724;1019.3985548526405;667.152716050613;706.7102487979904;715.7065603102807;725.6371814092954;754.8603508350973;4917.262410638433;4921.975390123026;5188.92216616751;5207.453217412193;5260.789568417221;378.5003794990586;394.82232995151725;395.28848073467645;397.9562248152701;398.43223406645416;3482.669146431085;3488.4592888102384;3560.145565064366;3587.0673624857723;3598.2803439312243;8852.822943541221;9282.211012063915;9308.069193080637;9308.20880225175;9324.673636422693;9175.954120229357;9183.265338772882;9237;9268.860967085498;9275.58259878307;6819.601981593762;6919.411849992706;6998.845190543503;6999.685014174374;7008.544444611084;5022.397312322545;5044.243363495505;5079.619028572945;5188.325517682828;5292;8450.281726053108;8513.95743021281;8526.190011948855;8528.957355213184;8625.439346442461;8368.12134725845;8584.957075214585;8602.612882420432;8637.970077032018;8774.824503510023;5560.499555040065;6434.581752186093;6566.6388348639375;6570.375814297634;6573.934260657332;6233.844153896189;6584.868302634016;6723.058771772054;6785.864282714219;6961.164660240804;6246.625202487865;6430;6488.480921526172;6488.9026664601015;6592.604443733391;6258.092576576462;6299.433051025429;6336.778212762715;6339.5562310637815;6403.583767055126;5826.475617194473;5834.03738383179;5846.181534585076;5846.590738648424;5846.970765146147;4148.937765933453;4185.204811085884;4212.136512015091;4270.508891477396;4399.120175964756;4080.673546116363;4117.691173162085;4119.217348703737;4183.769892655933;4394.1211757649235 04:40:36 INFO - PROCESS | 27479 | |4;prototype.html;276.10404238246883;276.98753556089974;284.0682561199267;284.6569883290635;286.7978075456803;4430.3449654035385;4603.169051033616;4739.909216656597;4761.238201887699;4787.40157480315;4235.428217190678;4652.371929789478;4662.650301227413;4664.813407463697;4684.367610372598;3489.3370259650587;3644.963550364502;3720.6465385788374;3721.9813900930594;3728.813559322023;3547.3260080584737;3694.3719567673425;3697;3697.297513472445;3702.61122582129;3683.4843121962945;3683.8710645127426;3688.760230585017;3694.242680250542;3696.1498855263308;3713.275911197318;3714.591394946554;3715.516982792247;3721.2557488502407;3731.8507259709577;3182.124915648192;3206.695363940445;3230.951535726966;3247.220667039917;3294;4549.47681016684;4556.567126123013;4558.407407037097;4560.657950653715;4573.153966516205;4139.648129908961;4151.356539736345;4152.190322887038;4154.252234597771;4156.646685031776;4660.813567457298;4825.20384136617;4828.251620998751;4830.154722923475;4837.927431088537;3417.9658203418144;3418.572678415198;3432.4508078707286;3435.7766745161734;3444.4144495435835;5121.82073627425;5129.692218466904;5141.871453213662;5150.896982060338;5173.611979101544;3440.6559344065895;3500.334936362083;3516.2440075383915;3546.627604101584;3563.2160924597065;3565.2512972275595;3572.5891522474726;3575.2313252650283;3586.605473397924;3593.9281214375565;4108.650764684976;4122.6083522065355;4135.31767258399;4143.523494798137;4148.979255103705;4656.348111264426;4708.576228139484;4794.161021821237;4854;4923.359963204761;1217.9269243845397;1230.4893469210178;1234.481517762542;1236.758832027764;1240.4046057892263;763.5876626621562;785.3285440948022;790.1940021178366;791.8257983243677;802.4102284820652;3954.426608141803;3972.82122304497;3978.622030907059;3982.5021872265966;3986.3023970804993;4447.086563823815;4454.665900057444;4456.821727130879;4472.977635111869;4477.440319960005;3945.3095708251517;3951.7036222283446;3982.303096958021;3986.3092412621363;3988.6637976277693;2278.259565641173;2357.7760112789256;2377.3699969508093;2379.3575734551573;2395.4788709169457;4256.616904478612;4278.7004909656025;4278.743275403485;4294.398784170218;4302.311630139163;4550.226461501553;4568.497465278817;4575.695926660886;4600.815967361335;4616.653750968623;4040.070783719761;4236.4704411948505;4261.634792690087;4263.637590804817;4279.165562715303;4335.349697545394;4410.625096866674;4426.1369033038245;4453.487848897418;4504.234280172313;4397.31841564558;4409.338599210144;4426.683983116436;4431.224535706303;4433;4079.653229475528;4185.497740271187;4266.957330426781;4285.721428107163;4318.654507639319;3205.423023855635;3232.3858466891215;3233.690355406064;3233.8221397822404;3237.579114715072;4437.511873693956;4476.350929115325;4502.887427814331;4506.9633984183165;4857.781399836945;4721.409823772028;4854.80580776765;4895.70263880065;4936.308916751729;4962.950370496394;4893.73084480357;4896.804127834846;4905;4912.975435122801;4917.188663870421;4612.815487380467;4827.179379505422;4828.179209534458;4852.466228714768;4869.831240502324;4964.429090654621;4965.4289756677;4980.252962055721;4990.276409920614;4995.550400463976;4877.731724755173;4881.194602890625;4885.853424397274;4889.535494128052;4890.266460031024 04:40:36 INFO - PROCESS | 27479 | |5;yui.html;618.6779465031354;632.9177206963094;699.4788882282697;714.6641078693012;717.9634861446947;13012.674683132926;14063.29683515824;14158.079724817879;14165.504207352744;14192.787108193384;12896.226226426397;13095.410706518205;13524.661883452894;13649.863501364984;13707.725845483084;617.102116420607;756.9924300756991;779.7699678594828;784.8194915169514;786.1509569664777;640.7116797441147;765.418282105601;791.4815795653856;796.1202870827739;799.2167675677839;825.413956091176;827.3298628111249;829.4069740135802;829.7925518620345;830.2361827119034;639.1371648274838;658.9670516474205;820.5897051474263;821.4003777242586;822.1572887790003;488.65793944239175;488.8509004753549;489.23190590772504;576.5387689848104;594.5303210463728;11772.352520611363;11774.234674746114;11780.116491263103;11831.171817972745;11842.111841611828;12279;12528.123031387806;12589.433475493624;12886.54897078607;13170.001388090164;9498.810023799555;9733.951330243373;11071.391073490955;11071.72320691989;11162.832557511563;4075.8981025474304;4122.216778812016;4150.086980864236;4221.261279276145;4322.978385108086;42292.78853605743;43858.780706096586;43961.78019109916;44012.779936100436;44085.11829763387;10063.39619622825;10335;10354.585816567253;10505.107065899332;10560.683179504627;18407.171677274553;18466.169022394024;18469.445916622524;18493.16780744843;18510.16704248312;6451.709673064724;6479.967600161969;6487.286398496161;6537.509686773511;6675.399214070757;3490.8433639216682;3521.7006554442646;3546.2730140321173;3550.396432606463;3574.7318951078773;2884.7980641355325;2990.357073229266;3007.248187953012;3008.4584774740756;3015.5627434021944;485.55086544945783;492.61575970742877;496.6945328622871;497.41553674432396;498.4741098141423;485.56299330602036;541.0828645445931;548.6050043968337;585.3736501942965;596.1623918394575;7840.13758486566;8053.6778528858185;8204.138565450661;8409.075001749803;8413.489164597198;465.853256224295;522.4488164985901;553.510143522977;586.9652218165286;618.9597676151036;3742.62573742629;3888.300105980894;3911.5264237686674;4004.299247631711;4055.6755459563165;52642.47357526376;88042.1195788034;93928;96652;96919;48996.77508062327;81456.59271703722;86143;86628;87014;45091.77454112709;65850.67074664596;73771.63114184394;73839.55486899432;74143.25856741364;7396.889046664412;7491.962540187482;7721.305082542598;7788.221177882167;7955.2840244378285;46199.30701039554;47107.29339059985;47380.2892956599;47806.521934780205;48805.5119448801;37314;46739.766301168274;51393.743031284605;53151.25735393339;57957.71021144867;10814.459277036274;11361.808618510926;11652.592159274385;11830.05359571215;11842.703932401759;12978.480860765463;13300.201987880759;13363.26502042397;13861.514846980308;14123.435062597791;10721.30311529748;11018.228723989243;11316.15128865355;11318.26431281964;11333.943330283295;11600.419979001184;12142.696432589257;12743.299118548199;13051.412686428943;13181.538646147339;10346.586136554453;10347.94826025865;10397.636082737068;10622.468876555986;11368.147388946027;10048.49757512136;10091.697249082246;10137;10165.644202452879;10446.947765261126;9048.638054477748;9083.273338132802;9109.225715813966;9245.72262832116;9436.622535098519 04:40:36 INFO - PROCESS | 27479 | __end_tp_report 04:40:36 INFO - PROCESS | 27479 | __start_cc_report 04:40:36 INFO - PROCESS | 27479 | _x_x_mozilla_cycle_collect,1453 04:40:36 INFO - PROCESS | 27479 | __end_cc_report 04:40:36 INFO - PROCESS | 27479 | __startTimestamp1476272436373__endTimestamp 04:40:36 INFO - PROCESS | 27479 | 04:40:36 INFO - PROCESS | 27479 | ------- Summary: start ------- 04:40:36 INFO - PROCESS | 27479 | Number of tests: 6 04:40:36 INFO - PROCESS | 27479 | 04:40:36 INFO - PROCESS | 27479 | [#0] dojo.html Cycles:165 Average:4488.08 Median:4619.08 stddev:449.33 (9.7%) stddev-sans-first:423.74 04:40:36 INFO - PROCESS | 27479 | Values: 2533.7 2555.5 2590.8 2604.1 2614.1 4404.5 4442.8 4497.7 4537.8 4542.2 4469.6 4521.7 4559.6 4571.0 4592.1 4135.9 4153.3 4206.4 4234.0 4256.3 4231.3 4240.7 4278.9 4281.6 4326.2 4103.9 4212.6 4215.2 4313.5 4332.6 4160.9 4163.3 4172.0 4224.9 4229.6 4190.3 4202.2 4203.7 4261.7 4269.7 4540.9 4542.6 4569.9 4584.3 4619.1 4694.1 4742.1 4745.1 4808.1 4933.4 4881.8 4894.5 4897.2 4901.5 4953.9 4562.8 4573.4 4575.1 4576.1 4628.5 4789.1 4838.9 4985.8 4990.6 5043.7 4681.6 4706.6 4716.7 4727.2 4789.0 4788.5 4790.1 4794.1 4807.9 4864.9 4758.8 4765.1 4771.5 4825.5 4829.3 4644.4 4646.4 4694.6 4749.7 4757.6 4055.1 4060.4 4060.5 4060.6 4060.7 3568.1 3594.0 3601.1 3612.1 3622.4 4288.5 4296.0 4306.5 4347.1 4356.3 4892.0 4897.3 4897.7 4898.9 4956.7 4145.9 4201.2 4239.1 4280.7 4284.5 4368.8 4375.2 4405.3 4424.6 4427.0 4603.8 4638.2 4642.7 4645.2 4702.4 4739.3 4745.9 4789.8 4876.7 4886.4 4554.1 4559.5 4566.7 4617.1 4626.6 4766.4 4769.7 4773.0 4775.2 4828.7 4639.0 4830.9 4838.6 4849.9 4907.8 4574.9 4672.9 4697.0 4716.5 4789.5 4726.6 4728.6 4731.2 4741.5 4786.9 4643.9 4670.8 4694.0 4698.5 4757.5 4617.7 4647.7 4668.6 4673.1 4781.3 4598.4 4607.7 4635.8 4646.4 4649.3 04:40:36 INFO - PROCESS | 27479 | 04:40:36 INFO - PROCESS | 27479 | [#1] ext.html Cycles:180 Average:47744.92 Median:35632.14 stddev:88449.53 (248.2%) stddev-sans-first:88626.74 04:40:36 INFO - PROCESS | 27479 | Values: 568.8 571.2 574.6 579.6 579.8 27409.5 37873.0 39314.2 39323.4 43488.0 39614.0 39914.8 39943.2 39978.4 40047.4 7592.5 7759.2 7767.7 7777.0 7781.9 7581.5 7668.0 7668.3 7669.1 7674.5 7659.1 7700.8 7703.0 7721.7 7722.3 7626.6 7661.4 7672.1 7673.1 7674.8 7573.4 7639.9 7643.8 7652.0 7654.4 37019.6 37393.8 37415.0 37533.0 37533.6 2870.8 3200.2 3553.9 3556.6 3650.8 28094.2 28220.6 28333.7 28429.1 29552.1 3487.7 3524.9 3536.0 3539.5 3587.7 256319.0 256819.7 257239.0 257544.0 258159.0 49931.0 50102.2 50131.0 50149.2 50157.2 32248.4 33604.3 33651.5 35602.5 35661.8 13918.4 14017.4 14049.4 14089.9 14109.2 10780.8 10842.5 10849.9 10866.5 10881.2 17550.5 17557.9 17648.2 17655.5 17717.1 6744.4 6842.6 6845.3 6862.0 7125.4 791.9 841.8 869.5 870.9 872.2 26553.5 27121.6 27274.7 27832.0 27835.9 918.0 928.7 946.4 949.8 1020.0 13642.5 14324.2 14515.4 14584.6 14681.6 345925.0 349818.0 350575.0 351788.0 352574.0 49340.8 49967.0 49988.8 50035.5 50090.5 1059.8 1103.0 1103.1 1146.0 1178.1 20540.9 27967.7 28784.4 30519.8 30842.4 45129.5 45214.3 47125.5 47198.8 52216.7 382110.0 386897.0 387002.0 387196.0 387447.0 29634.3 30035.2 37328.4 37415.0 37934.6 30498.1 39648.0 40102.4 40225.6 40489.8 33697.5 34044.0 34123.0 34747.3 35437.6 34239.8 34644.0 34733.7 35118.0 35119.3 30310.2 30970.4 34201.1 34705.1 38330.4 30027.0 33027.0 33127.7 33144.7 33216.2 23926.2 24903.8 25061.4 25272.5 25381.5 04:40:36 INFO - PROCESS | 27479 | 04:40:36 INFO - PROCESS | 27479 | [#2] jquery.html Cycles:180 Average:24912.45 Median:5139.99 stddev:64946.84 (1263.6%) stddev-sans-first:65102.83 04:40:36 INFO - PROCESS | 27479 | Values: 339.1 345.5 349.4 352.7 373.1 12036.5 13086.4 16024.6 16923.9 17219.7 15821.0 16897.7 16914.7 17067.0 17107.3 4429.8 4634.5 5004.7 5243.4 5246.4 5033.9 5194.7 5202.1 5203.6 5205.8 4990.2 5053.4 5107.9 5130.9 5137.5 5058.3 5135.3 5142.5 5142.8 5153.9 4589.1 4599.3 4603.8 4606.5 6044.2 21872.0 22009.6 22460.2 22600.7 22680.8 1960.9 2066.0 2166.5 2208.1 2516.4 13532.9 14282.5 14333.5 14736.1 15024.2 1783.3 1890.3 1895.4 1938.6 1968.3 72936.0 75981.0 76221.0 78906.6 80628.6 15539.4 15907.4 16122.4 16179.8 16761.7 28227.2 28286.4 28332.7 28469.0 28493.1 8496.0 8763.0 8846.4 9040.5 9193.0 7135.4 7314.6 7322.7 7441.8 7531.0 8011.5 8187.4 8260.6 8425.6 8448.6 3172.4 3380.7 3422.4 3422.8 3530.1 751.8 825.5 825.6 831.2 945.0 16199.8 16566.2 16673.7 16745.9 17489.5 811.7 845.3 856.3 884.5 886.8 8547.9 9527.8 9585.8 9593.5 9607.5 388206.0 390630.0 394414.0 396365.0 399185.0 69823.3 70856.9 71566.6 74347.6 74490.9 905.2 926.5 946.9 949.8 952.9 14247.8 14361.9 14633.3 14714.8 15146.5 33754.3 33978.5 34413.3 34697.8 35531.2 46812.0 47002.8 47267.3 47698.0 48063.3 6490.5 6494.7 6629.3 6734.8 6869.5 9293.6 9652.6 9882.8 9987.4 10012.7 8872.9 8957.6 8983.7 9029.4 9196.5 8666.3 8848.7 9075.9 9083.1 9174.6 8966.1 9026.9 9098.2 9331.4 9554.8 6301.4 6423.2 6522.9 6618.1 6860.7 6478.4 8145.5 8453.7 8732.0 8882.1 04:40:36 INFO - PROCESS | 27479 | 04:40:36 INFO - PROCESS | 27479 | [#3] mootools.html Cycles:180 Average:4810.43 Median:5033.32 stddev:2741.31 (54.5%) stddev-sans-first:2735.81 04:40:36 INFO - PROCESS | 27479 | Values: 1231.9 1340.9 1365.5 1426.7 1657.3 6331.0 7155.2 7395.3 7447.1 7693.5 7502.8 7587.4 7591.9 7593.5 7603.1 2096.5 2102.1 2130.1 2130.5 2133.4 2067.0 2105.7 2122.1 2122.6 2125.6 2065.6 2091.7 2096.6 2102.8 2134.7 2057.8 2062.3 2063.0 2064.4 2065.3 2046.3 2061.3 2094.8 2097.4 2101.9 7408.1 7450.8 7459.5 7468.5 7477.4 4103.4 4247.8 4248.4 4291.4 4298.5 2570.4 2697.4 2758.7 2760.1 2764.3 897.8 912.5 917.2 922.7 926.1 9966.8 10002.9 10068.1 10077.5 10122.1 3607.4 3745.3 3840.6 3855.3 3865.8 7946.5 7955.8 7973.3 7973.8 7981.6 4147.9 4155.1 4157.1 4157.5 4168.2 3311.2 3413.7 3724.2 3779.1 3820.9 3123.7 3155.7 3239.4 3242.7 3282.9 991.6 1004.7 1005.3 1007.2 1019.4 667.2 706.7 715.7 725.6 754.9 4917.3 4922.0 5188.9 5207.5 5260.8 378.5 394.8 395.3 398.0 398.4 3482.7 3488.5 3560.1 3587.1 3598.3 8852.8 9282.2 9308.1 9308.2 9324.7 9176.0 9183.3 9237.0 9268.9 9275.6 6819.6 6919.4 6998.8 6999.7 7008.5 5022.4 5044.2 5079.6 5188.3 5292.0 8450.3 8514.0 8526.2 8529.0 8625.4 8368.1 8585.0 8602.6 8638.0 8774.8 5560.5 6434.6 6566.6 6570.4 6573.9 6233.8 6584.9 6723.1 6785.9 6961.2 6246.6 6430.0 6488.5 6488.9 6592.6 6258.1 6299.4 6336.8 6339.6 6403.6 5826.5 5834.0 5846.2 5846.6 5847.0 4148.9 4185.2 4212.1 4270.5 4399.1 4080.7 4117.7 4119.2 4183.8 4394.1 04:40:36 INFO - PROCESS | 27479 | 04:40:36 INFO - PROCESS | 27479 | [#4] prototype.html Cycles:180 Average:3909.76 Median:4278.95 stddev:1130.27 (26.4%) stddev-sans-first:1100.05 04:40:36 INFO - PROCESS | 27479 | Values: 276.1 277.0 284.1 284.7 286.8 4430.3 4603.2 4739.9 4761.2 4787.4 4235.4 4652.4 4662.7 4664.8 4684.4 3489.3 3645.0 3720.6 3722.0 3728.8 3547.3 3694.4 3697.0 3697.3 3702.6 3683.5 3683.9 3688.8 3694.2 3696.1 3713.3 3714.6 3715.5 3721.3 3731.9 3182.1 3206.7 3231.0 3247.2 3294.0 4549.5 4556.6 4558.4 4560.7 4573.2 4139.6 4151.4 4152.2 4154.3 4156.6 4660.8 4825.2 4828.3 4830.2 4837.9 3418.0 3418.6 3432.5 3435.8 3444.4 5121.8 5129.7 5141.9 5150.9 5173.6 3440.7 3500.3 3516.2 3546.6 3563.2 3565.3 3572.6 3575.2 3586.6 3593.9 4108.7 4122.6 4135.3 4143.5 4149.0 4656.3 4708.6 4794.2 4854.0 4923.4 1217.9 1230.5 1234.5 1236.8 1240.4 763.6 785.3 790.2 791.8 802.4 3954.4 3972.8 3978.6 3982.5 3986.3 4447.1 4454.7 4456.8 4473.0 4477.4 3945.3 3951.7 3982.3 3986.3 3988.7 2278.3 2357.8 2377.4 2379.4 2395.5 4256.6 4278.7 4278.7 4294.4 4302.3 4550.2 4568.5 4575.7 4600.8 4616.7 4040.1 4236.5 4261.6 4263.6 4279.2 4335.3 4410.6 4426.1 4453.5 4504.2 4397.3 4409.3 4426.7 4431.2 4433.0 4079.7 4185.5 4267.0 4285.7 4318.7 3205.4 3232.4 3233.7 3233.8 3237.6 4437.5 4476.4 4502.9 4507.0 4857.8 4721.4 4854.8 4895.7 4936.3 4963.0 4893.7 4896.8 4905.0 4913.0 4917.2 4612.8 4827.2 4828.2 4852.5 4869.8 4964.4 4965.4 4980.3 4990.3 4995.6 4877.7 4881.2 4885.9 4889.5 4890.3 04:40:36 INFO - PROCESS | 27479 | 04:40:36 INFO - PROCESS | 27479 | [#5] yui.html Cycles:180 Average:16203.73 Median:23332.58 stddev:22434.95 (96.2%) stddev-sans-first:22467.37 04:40:36 INFO - PROCESS | 27479 | Values: 618.7 632.9 699.5 714.7 718.0 13012.7 14063.3 14158.1 14165.5 14192.8 12896.2 13095.4 13524.7 13649.9 13707.7 617.1 757.0 779.8 784.8 786.2 640.7 765.4 791.5 796.1 799.2 825.4 827.3 829.4 829.8 830.2 639.1 659.0 820.6 821.4 822.2 488.7 488.9 489.2 576.5 594.5 11772.4 11774.2 11780.1 11831.2 11842.1 12279.0 12528.1 12589.4 12886.5 13170.0 9498.8 9734.0 11071.4 11071.7 11162.8 4075.9 4122.2 4150.1 4221.3 4323.0 42292.8 43858.8 43961.8 44012.8 44085.1 10063.4 10335.0 10354.6 10505.1 10560.7 18407.2 18466.2 18469.4 18493.2 18510.2 6451.7 6480.0 6487.3 6537.5 6675.4 3490.8 3521.7 3546.3 3550.4 3574.7 2884.8 2990.4 3007.2 3008.5 3015.6 485.6 492.6 496.7 497.4 498.5 485.6 541.1 548.6 585.4 596.2 7840.1 8053.7 8204.1 8409.1 8413.5 465.9 522.4 553.5 587.0 619.0 3742.6 3888.3 3911.5 4004.3 4055.7 52642.5 88042.1 93928.0 96652.0 96919.0 48996.8 81456.6 86143.0 86628.0 87014.0 45091.8 65850.7 73771.6 73839.6 74143.3 7396.9 7492.0 7721.3 7788.2 7955.3 46199.3 47107.3 47380.3 47806.5 48805.5 37314.0 46739.8 51393.7 53151.3 57957.7 10814.5 11361.8 11652.6 11830.1 11842.7 12978.5 13300.2 13363.3 13861.5 14123.4 10721.3 11018.2 11316.2 11318.3 11333.9 11600.4 12142.7 12743.3 13051.4 13181.5 10346.6 10347.9 10397.6 10622.5 11368.1 10048.5 10091.7 10137.0 10165.6 10446.9 9048.6 9083.3 9109.2 9245.7 9436.6 04:40:36 INFO - PROCESS | 27479 | -------- Summary: end -------- 04:40:36 INFO - PROCESS | 27479 | 04:40:37 INFO - TEST-INFO | 27479: exit 0 04:40:37 INFO - TEST-OK | dromaeo_css | took 1121956ms 04:40:37 INFO - TEST-START | kraken 04:40:37 INFO - operating with platform_type : linux_ 04:40:37 INFO - Initialising browser for kraken test... 04:40:37 INFO - TEST-INFO | started process 27784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAriPjO/profile http://localhost:55088/getInfo.html) 04:40:41 INFO - PROCESS | 27784 | __metrics Screen width/height:1600/1200 04:40:41 INFO - PROCESS | 27784 | colorDepth:24 04:40:41 INFO - PROCESS | 27784 | Browser inner width/height: 1024/697 04:40:41 INFO - PROCESS | 27784 | __metrics 04:40:42 INFO - PROCESS | 27784 | 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" 04:40:42 INFO - PROCESS | 27784 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:42 INFO - PROCESS | 27784 | console.error: PushService: 04:40:42 INFO - PROCESS | 27784 | stateChangeProcessEnqueue: Error transitioning state 04:40:42 INFO - PROCESS | 27784 | UnknownError 04:40:43 INFO - TEST-INFO | 27784: exit 0 04:40:43 INFO - Browser initialized. 04:40:43 INFO - Running cycle 1/1 for kraken test... 04:40:43 INFO - TEST-INFO | started process 27866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAriPjO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:55 INFO - PROCESS | 27866 | RSS: Main: 174727168 04:40:55 INFO - PROCESS | 27866 | 04:40:58 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55088/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:59 INFO - PROCESS | 27866 | RSS: Main: 233041920 04:40:59 INFO - PROCESS | 27866 | 04:41:02 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55088/tests/kraken/driver.html?testName=audio-dft) 04:41:02 INFO - PROCESS | 27866 | RSS: Main: 217944064 04:41:02 INFO - PROCESS | 27866 | 04:41:06 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55088/tests/kraken/driver.html?testName=audio-fft) 04:41:06 INFO - PROCESS | 27866 | RSS: Main: 300871680 04:41:06 INFO - PROCESS | 27866 | 04:41:08 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55088/tests/kraken/driver.html?testName=audio-oscillator) 04:41:09 INFO - PROCESS | 27866 | RSS: Main: 208388096 04:41:09 INFO - PROCESS | 27866 | 04:41:11 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55088/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:12 INFO - PROCESS | 27866 | RSS: Main: 213643264 04:41:12 INFO - PROCESS | 27866 | 04:41:15 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55088/tests/kraken/driver.html?testName=imaging-darkroom) 04:41:16 INFO - PROCESS | 27866 | RSS: Main: 250253312 04:41:16 INFO - PROCESS | 27866 | 04:41:19 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55088/tests/kraken/driver.html?testName=imaging-desaturate) 04:41:20 INFO - PROCESS | 27866 | RSS: Main: 248635392 04:41:20 INFO - PROCESS | 27866 | 04:41:23 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55088/tests/kraken/driver.html?testName=json-parse-financial) 04:41:23 INFO - PROCESS | 27866 | RSS: Main: 248238080 04:41:23 INFO - PROCESS | 27866 | 04:41:25 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55088/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:26 INFO - PROCESS | 27866 | RSS: Main: 210751488 04:41:26 INFO - PROCESS | 27866 | 04:41:27 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:28 INFO - PROCESS | 27866 | RSS: Main: 218566656 04:41:28 INFO - PROCESS | 27866 | 04:41:30 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:31 INFO - PROCESS | 27866 | RSS: Main: 227020800 04:41:31 INFO - PROCESS | 27866 | 04:41:34 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:34 INFO - PROCESS | 27866 | RSS: Main: 230555648 04:41:34 INFO - PROCESS | 27866 | 04:41:37 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:38 INFO - PROCESS | 27866 | RSS: Main: 232009728 04:41:38 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | Cycle 1(1): loaded http://localhost:55088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55088/tests/kraken/driver.html?testName=ai-astar) 04:41:40 INFO - PROCESS | 27866 | RSS: Main: 282054656 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | __start_tp_report 04:41:40 INFO - PROCESS | 27866 | _x_x_mozilla_page_load 04:41:40 INFO - PROCESS | 27866 | _x_x_mozilla_page_load_details 04:41:40 INFO - PROCESS | 27866 | |i|pagename|runs| 04:41:40 INFO - PROCESS | 27866 | |0;ai-astar;111;113;113;115;114;115;114;117;113;114 04:41:40 INFO - PROCESS | 27866 | |1;audio-beat-detection;160;133;127;168;134;132;136;129;164;129 04:41:40 INFO - PROCESS | 27866 | |2;audio-dft;162;161;163;163;163;162;161;162;160;161 04:41:40 INFO - PROCESS | 27866 | |3;audio-fft;75;76;76;114;76;77;78;76;111;76 04:41:40 INFO - PROCESS | 27866 | |4;audio-oscillator;85;83;110;83;85;83;108;84;84;124 04:41:40 INFO - PROCESS | 27866 | |5;imaging-gaussian-blur;116;117;117;117;116;118;116;117;117;117 04:41:40 INFO - PROCESS | 27866 | |6;imaging-darkroom;146;147;146;147;147;146;147;147;146;146 04:41:40 INFO - PROCESS | 27866 | |7;imaging-desaturate;95;96;96;96;96;96;95;95;95;96 04:41:40 INFO - PROCESS | 27866 | |8;json-parse-financial;67;66;66;66;66;68;67;67;66;74 04:41:40 INFO - PROCESS | 27866 | |9;json-stringify-tinderbox;67;66;66;66;66;66;67;66;67;67 04:41:40 INFO - PROCESS | 27866 | |10;stanford-crypto-aes;83;83;86;93;83;88;83;84;88;83 04:41:40 INFO - PROCESS | 27866 | |11;stanford-crypto-ccm;140;140;139;140;139;140;142;156;190;140 04:41:40 INFO - PROCESS | 27866 | |12;stanford-crypto-pbkdf2;179;180;183;182;177;177;175;175;175;173 04:41:40 INFO - PROCESS | 27866 | |13;stanford-crypto-sha256-iterative;73;74;78;73;70;70;69;69;70;72 04:41:40 INFO - PROCESS | 27866 | __end_tp_report 04:41:40 INFO - PROCESS | 27866 | __start_cc_report 04:41:40 INFO - PROCESS | 27866 | _x_x_mozilla_cycle_collect,1936 04:41:40 INFO - PROCESS | 27866 | __end_cc_report 04:41:40 INFO - PROCESS | 27866 | __startTimestamp1476272500631__endTimestamp 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | ------- Summary: start ------- 04:41:40 INFO - PROCESS | 27866 | Number of tests: 14 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:1.60 (1.4%) stddev-sans-first:1.30 04:41:40 INFO - PROCESS | 27866 | Values: 111.0 113.0 113.0 115.0 114.0 115.0 114.0 117.0 113.0 114.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:135.00 stddev:16.06 (11.9%) stddev-sans-first:15.53 04:41:40 INFO - PROCESS | 27866 | Values: 160.0 133.0 127.0 168.0 134.0 132.0 136.0 129.0 164.0 129.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 04:41:40 INFO - PROCESS | 27866 | Values: 162.0 161.0 163.0 163.0 163.0 162.0 161.0 162.0 160.0 161.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:15.32 (20.2%) stddev-sans-first:15.94 04:41:40 INFO - PROCESS | 27866 | Values: 75.0 76.0 76.0 114.0 76.0 77.0 78.0 76.0 111.0 76.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:83.50 stddev:15.15 (18.1%) stddev-sans-first:15.79 04:41:40 INFO - PROCESS | 27866 | Values: 85.0 83.0 110.0 83.0 85.0 83.0 108.0 84.0 84.0 124.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 04:41:40 INFO - PROCESS | 27866 | Values: 116.0 117.0 117.0 117.0 116.0 118.0 116.0 117.0 117.0 117.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:41:40 INFO - PROCESS | 27866 | Values: 146.0 147.0 146.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:41:40 INFO - PROCESS | 27866 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:67.00 stddev:2.45 (3.7%) stddev-sans-first:2.60 04:41:40 INFO - PROCESS | 27866 | Values: 67.0 66.0 66.0 66.0 66.0 68.0 67.0 67.0 66.0 74.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 04:41:40 INFO - PROCESS | 27866 | Values: 67.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 67.0 67.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:3.37 (4.0%) stddev-sans-first:3.46 04:41:40 INFO - PROCESS | 27866 | Values: 83.0 83.0 86.0 93.0 83.0 88.0 83.0 84.0 88.0 83.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:140.00 stddev:16.08 (11.5%) stddev-sans-first:16.87 04:41:40 INFO - PROCESS | 27866 | Values: 140.0 140.0 139.0 140.0 139.0 140.0 142.0 156.0 190.0 140.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:178.00 stddev:3.31 (1.9%) stddev-sans-first:3.47 04:41:40 INFO - PROCESS | 27866 | Values: 179.0 180.0 183.0 182.0 177.0 177.0 175.0 175.0 175.0 173.0 04:41:40 INFO - PROCESS | 27866 | 04:41:40 INFO - PROCESS | 27866 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.50 stddev:2.82 (3.9%) stddev-sans-first:2.96 04:41:40 INFO - PROCESS | 27866 | Values: 73.0 74.0 78.0 73.0 70.0 70.0 69.0 69.0 70.0 72.0 04:41:40 INFO - PROCESS | 27866 | -------- Summary: end -------- 04:41:40 INFO - PROCESS | 27866 | 04:41:41 INFO - TEST-INFO | 27866: exit 0 04:41:41 INFO - TEST-OK | kraken | took 64668ms 04:41:41 INFO - SUITE-END | took 1186s 04:41:42 INFO - Completed test suite (00:19:46) 04:41:42 INFO - javascript benchmark 04:41:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2533.746625337466, 2555.4505781257026, 2590.7797837183834, 2604.1015849531905, 2614.0981361430313, 4404.493483249419, 4442.755648439334, 4497.662675299353, 4537.84117555886, 4542.227821270384, 4469.642428605712, 4521.660875434339, 4559.566841150094, 4571.040081582872, 4592.058627981256, 4135.855245066423, 4153.314703073989, 4206.432131662217, 4234.047339348653, 4256.318988961767, 4231.259529582326, 4240.745555266679, 4278.871633850989, 4281.593248641389, 4326.242907491192, 4103.938440923389, 4212.557681443465, 4215.199112168709, 4313.547077556843, 4332.610065094141, 4160.895977600554, 4163.333866581333, 4171.958280417188, 4224.894377640584, 4229.577042295746, 4190.28765109929, 4202.159568086395, 4203.6637069034405, 4261.6803739719335, 4269.658427325838, 4540.931886021713, 4542.591166795004, 4569.862904112882, 4584.312353147021, 4619.076184763061, 4694.0611877624615, 4742.146413645542, 4745.145873742725, 4808.062427826575, 4933.407991041062, 4881.755912204411, 4894.5105489451125, 4897.1674815281485, 4901.485344038896, 4953.876153096166, 4562.771861406916, 4573.382593349922, 4575.10785396851, 4576.084783043405, 4628.5371462853445, 4789.137955168103, 4838.879028024327, 4985.750712464363, 4990.600751939836, 5043.722595257296, 4681.648876334289, 4706.623470122382, 4716.6698331116495, 4727.220008698595, 4789.0, 4788.473267940523, 4790.089882922233, 4794.113089078532, 4807.903841923142, 4864.902701945941, 4758.833440829554, 4765.11845308619, 4771.5228477152705, 4825.469198388175, 4829.348038014893, 4644.419447569054, 4646.442426908725, 4694.577488026094, 4749.691270067435, 4757.595604373598, 4055.1281474483126, 4060.3909413587608, 4060.451839001756, 4060.614241647039, 4060.675145988373, 3568.107973006748, 3593.964060359363, 3601.135727425399, 3612.078919875415, 3622.42041273395, 4288.5282618912515, 4296.0, 4306.4832220133785, 4347.065380943112, 4356.302991521405, 4891.975540122347, 4897.314375987365, 4897.706137631682, 4898.8775280618265, 4956.653034287565, 4145.91708165835, 4201.243776120266, 4239.109786944715, 4280.743155410685, 4284.485861696617, 4368.7815609219415, 4375.16871794358, 4405.31717583775, 4424.60178583929, 4427.0, 4603.792829322621, 4638.1883170445035, 4642.698224615322, 4645.163870503342, 4702.435707715096, 4739.289106634033, 4745.857624271277, 4789.784459699252, 4876.707397556158, 4886.364772579542, 4554.089182163647, 4559.498455169863, 4566.725996440225, 4617.053504031598, 4626.583607475343, 4766.356541866804, 4769.689970151929, 4772.976135119302, 4775.164346239464, 4828.66199366055, 4639.0, 4830.855074347775, 4838.612910967185, 4849.927251091307, 4907.803687852446, 4574.931376029295, 4672.9299060514795, 4696.976515117402, 4716.504766999416, 4789.544993225638, 4726.62187025044, 4728.621710263102, 4731.243001119942, 4741.525847415369, 4786.904261914812, 4643.930341044955, 4670.789814458425, 4693.9765301173275, 4698.483166851575, 4757.500462451393, 4617.722936623813, 4647.674662773574, 4668.626509879269, 4673.135469938073, 4781.282807578891, 4598.3792188054185, 4607.723536587815, 4635.791389387418, 4646.372739680235, 4649.325847751989], "value": 4460.585323973794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.8435680187949, 571.2060236271583, 574.5719439017932, 579.5508480927281, 579.7825815319255, 27409.45181096377, 37873.0, 39314.213715725666, 39323.41014884779, 43488.0, 39614.0, 39914.8004259979, 39943.20113597734, 39978.40032399516, 40047.39928901062, 7592.468527203098, 7759.185285544993, 7767.6504557294775, 7776.961115194416, 7781.8832717509, 7581.507202031878, 7668.0, 7668.348190403823, 7669.0797104347275, 7674.53952762836, 7659.119201291867, 7700.807479812994, 7703.037120359955, 7721.691132354699, 7722.266384693473, 7626.618669066552, 7661.387089032864, 7672.079350477979, 7673.079230492321, 7674.769756907302, 7573.431992600522, 7639.9236007639765, 7643.770686879402, 7651.961740191319, 7654.4259180561685, 37019.629803701886, 37393.813030934674, 37415.0, 37533.0, 37533.62466375329, 2870.799044066916, 3200.1839530919465, 3553.9111522211892, 3556.590992035897, 3650.817459127033, 28094.157175284774, 28220.576691349645, 28333.71666283352, 28429.147125586267, 29552.113436596937, 3487.720982321408, 3524.8942531724088, 3535.9646403535894, 3539.52216450781, 3587.7488575799703, 256319.0, 256819.71590142118, 257239.0, 257544.0, 258159.0, 49931.0, 50102.24028717266, 50131.0, 50149.24776128361, 50157.24764128541, 32248.35503289921, 33604.32791344159, 33651.495227571606, 35602.465963010574, 35661.8216908919, 13918.443262269397, 14017.369218385196, 14049.367778449994, 14089.85910140906, 14109.223992680501, 10780.784384312426, 10842.457877106113, 10849.891501084889, 10866.45667716611, 10881.238313317992, 17550.473485795446, 17557.927362711474, 17648.205830737646, 17655.470335889688, 17717.11414429299, 6744.426723728538, 6842.589444633239, 6845.281245469154, 6862.0, 7125.42996560274, 791.9326857217086, 841.7853447370882, 869.4870026684287, 870.9477431354139, 872.1932212703351, 26553.468930621664, 27121.593176102375, 27274.727252727615, 27832.0, 27835.860820695765, 917.9770505737276, 928.7353104365224, 946.4132238012477, 949.7957939043139, 1020.0156848640949, 13642.52251171224, 14324.212168330841, 14515.419383224764, 14584.56246312591, 14681.559553213421, 345925.0, 349818.0, 350575.0, 351788.0, 352574.0, 49340.75329623329, 49967.0, 49988.75005624948, 50035.49964500308, 50090.499095008585, 1059.8357254625546, 1102.9558817647205, 1103.1175059952166, 1145.954161833534, 1178.1458442629196, 20540.897295513427, 27967.72032279651, 28784.42431151407, 30519.847400762854, 30842.38315233638, 45129.548704512534, 45214.32178517259, 47125.52874471348, 47198.76400617975, 52216.73891630518, 382110.0, 386897.0, 387002.0, 387196.0, 387447.0, 29634.259143521584, 30035.19788812591, 37328.44007339838, 37415.0, 37934.62065379311, 30498.085057448312, 39648.0, 40102.39846402248, 40225.597744023355, 40489.79755101324, 33697.494537582446, 34044.0, 34123.0, 34747.30505389928, 35437.64562354344, 34239.82880085584, 34644.0, 34733.65266347405, 35118.0, 35119.29761404809, 30310.242243944078, 30970.380592388476, 34201.144971375914, 34705.13237169091, 38330.42504362493, 30027.0, 33027.0, 33127.66872331342, 33144.66855331416, 33216.1695957603, 23926.162584309466, 24903.750962490143, 25061.373465663506, 25272.494550109262, 25381.492370152126], "value": 17230.040193663557, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.13689659815765, 345.5414724237053, 349.3676445633403, 352.6984428313791, 373.10268803527526, 12036.518539258419, 13086.411111499981, 16024.599385015366, 16923.91538042311, 17219.741703874453, 15821.0, 16897.66204675906, 16914.74627880583, 17067.0, 17107.31570737169, 4429.77851107445, 4634.513376095495, 5004.7497625118685, 5243.449437809032, 5246.422893481714, 5033.874153146164, 5194.740262986855, 5202.115640341132, 5203.583713302945, 5205.843824685266, 4990.201567749161, 5053.418856831475, 5107.948920510803, 5130.9230361544605, 5137.48625137487, 5058.266551350052, 5135.3067335909545, 5142.485751424865, 5142.768575414097, 5153.922691159635, 4589.105124500724, 4599.333096700993, 4603.792829322689, 4606.516315786861, 6044.24446944132, 21872.0, 22009.559808803893, 22460.213892513846, 22600.66099008516, 22680.773192268196, 1960.8725432846961, 2065.979340206594, 2166.5450255446376, 2208.1277895231456, 2516.4086439686657, 13532.917366610647, 14282.500112496013, 14333.49832755859, 14736.115833050051, 15024.248787560688, 1783.3134243316288, 1890.3478299986482, 1895.4313705888178, 1938.5557759469286, 1968.3307675390436, 72936.0, 75981.0, 76221.0, 78906.60546697288, 80628.59685701593, 15539.378424863105, 15907.443239486562, 16122.435714750161, 16179.822456813707, 16761.7485737714, 28227.15318540447, 28286.434271314458, 28332.71667283301, 28469.00358487443, 28493.145205643865, 8495.95752021236, 8763.0, 8846.380753347205, 9040.457572545536, 9192.95403522978, 7135.393491553276, 7314.622747607049, 7322.743703970335, 7441.813954651068, 7531.0, 8011.479253848481, 8187.4268801184535, 8260.586970651564, 8425.578721063923, 8448.619812108469, 3172.397244523533, 3380.695737383647, 3422.401079811023, 3422.760406771502, 3530.099824544776, 751.8082888863414, 825.529448214512, 825.6243409248777, 831.1522247307712, 945.0, 16199.75700364472, 16566.17169141538, 16673.74989375136, 16745.91627041857, 17489.475315740547, 811.6834434570522, 845.3237410071918, 856.2550580994574, 884.5311984648147, 886.7650072730731, 8547.91399117524, 9527.761805954768, 9585.808283834283, 9593.520323983774, 9607.51962401877, 388206.0, 390630.0, 394414.02792986424, 396365.0, 399185.0, 69823.30176698168, 70856.93714594285, 71566.64216678884, 74347.62826185835, 74490.88263676049, 905.2486436258022, 926.4580220570907, 946.9337146399823, 949.8147861167145, 952.9190018848337, 14247.786283205967, 14361.856381436051, 14633.268336582916, 14714.77927831062, 15146.545603631468, 33754.31228438519, 33978.490322644684, 34413.31173376569, 34697.826510867286, 35531.249062678005, 46812.0, 47002.76498617485, 47267.29099063448, 47698.0, 48063.279050813566, 6490.513211509061, 6494.740210391531, 6629.3039230882, 6734.764283250062, 6869.519133660596, 9293.581788819654, 9652.613895444103, 9882.752931176778, 9987.350822196535, 10012.749681258027, 8872.911270887209, 8957.641694332415, 8983.730488085368, 9029.41308814925, 9196.54017299119, 8666.263367613823, 8848.734537963872, 9075.863862041942, 9083.091690831128, 9174.587143578421, 8966.148215919477, 9026.85164911723, 9098.226650734761, 9331.440113593206, 9554.761130971781, 6301.40136687014, 6423.197100362455, 6522.902156467751, 6618.07346971434, 6860.656967151523, 6478.449331806661, 8145.511269323622, 8453.746387608382, 8731.956340218258, 8882.067382924959], "value": 8606.972905103272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.9137660363779, 1340.8592097829728, 1365.4947669362336, 1426.728921504914, 1657.3453485873074, 6331.0, 7155.248698886614, 7395.334419902208, 7447.106347238339, 7693.538387696742, 7502.774916752506, 7587.430942679293, 7591.8861217081785, 7593.468457207998, 7603.125640551324, 2096.486360841592, 2102.106604693007, 2130.052126803573, 2130.541933484308, 2133.4026472587702, 2066.9689954650694, 2105.652567326397, 2122.0875023739786, 2122.596706625744, 2125.6280150973594, 2065.648839697255, 2091.6967039779224, 2096.6330892093897, 2102.7686954435, 2134.658454647257, 2057.77364489906, 2062.3297428335777, 2062.979370206309, 2064.370367038053, 2065.3390914907236, 2046.31448464763, 2061.3403710812545, 2094.790520947908, 2097.370788763365, 2101.9474513137293, 7408.073990751156, 7450.776476705708, 7459.477836551444, 7468.47720659554, 7477.401807855358, 4103.4050062741035, 4247.766372849492, 4248.383984322287, 4291.35629655551, 4298.548652391485, 2570.370259286468, 2697.447023360226, 2758.7379198976264, 2760.1167626359575, 2764.3089227693076, 897.8428774964356, 912.5163663258484, 917.1837065012145, 922.7001224601964, 926.1063074133426, 9966.750831229205, 10002.949690282489, 10068.093871551522, 10077.546510406975, 10122.089011988883, 3607.4408466687705, 3745.344564701221, 3840.635139661728, 3855.3445914194654, 3865.845366185321, 7946.4834785739895, 7955.761327160194, 7973.2824045835, 7973.840523189504, 7981.600919953979, 4147.8963025924595, 4155.10665206982, 4157.085441202991, 4157.459530261047, 4168.166366726606, 3311.1556553079295, 3413.7098346640814, 3724.1620635356826, 3779.093017675738, 3820.8662696805477, 3123.6720144384512, 3155.7475401967786, 3239.400710868497, 3242.7243684286627, 3282.9343413132083, 991.5884907763198, 1004.6785028790716, 1005.2762011351815, 1007.2093406675724, 1019.3985548526405, 667.152716050613, 706.7102487979904, 715.7065603102807, 725.6371814092954, 754.8603508350973, 4917.262410638433, 4921.975390123026, 5188.92216616751, 5207.453217412193, 5260.789568417221, 378.5003794990586, 394.82232995151725, 395.28848073467645, 397.9562248152701, 398.43223406645416, 3482.669146431085, 3488.4592888102384, 3560.145565064366, 3587.0673624857723, 3598.2803439312243, 8852.822943541221, 9282.211012063915, 9308.069193080637, 9308.20880225175, 9324.673636422693, 9175.954120229357, 9183.265338772882, 9237.0, 9268.860967085498, 9275.58259878307, 6819.601981593762, 6919.411849992706, 6998.845190543503, 6999.685014174374, 7008.544444611084, 5022.397312322545, 5044.243363495505, 5079.619028572945, 5188.325517682828, 5292.0, 8450.281726053108, 8513.95743021281, 8526.190011948855, 8528.957355213184, 8625.439346442461, 8368.12134725845, 8584.957075214585, 8602.612882420432, 8637.970077032018, 8774.824503510023, 5560.499555040065, 6434.581752186093, 6566.6388348639375, 6570.375814297634, 6573.934260657332, 6233.844153896189, 6584.868302634016, 6723.058771772054, 6785.864282714219, 6961.164660240804, 6246.625202487865, 6430.0, 6488.480921526172, 6488.9026664601015, 6592.604443733391, 6258.092576576462, 6299.433051025429, 6336.778212762715, 6339.5562310637815, 6403.583767055126, 5826.475617194473, 5834.03738383179, 5846.181534585076, 5846.590738648424, 5846.970765146147, 4148.937765933453, 4185.204811085884, 4212.136512015091, 4270.508891477396, 4399.120175964756, 4080.673546116363, 4117.691173162085, 4119.217348703737, 4183.769892655933, 4394.1211757649235], "value": 3795.5670422484886, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.10404238246883, 276.98753556089974, 284.0682561199267, 284.6569883290635, 286.7978075456803, 4430.3449654035385, 4603.169051033616, 4739.909216656597, 4761.238201887699, 4787.40157480315, 4235.428217190678, 4652.371929789478, 4662.650301227413, 4664.813407463697, 4684.367610372598, 3489.3370259650587, 3644.963550364502, 3720.6465385788374, 3721.9813900930594, 3728.813559322023, 3547.3260080584737, 3694.3719567673425, 3697.0, 3697.297513472445, 3702.61122582129, 3683.4843121962945, 3683.8710645127426, 3688.760230585017, 3694.242680250542, 3696.1498855263308, 3713.275911197318, 3714.591394946554, 3715.516982792247, 3721.2557488502407, 3731.8507259709577, 3182.124915648192, 3206.695363940445, 3230.951535726966, 3247.220667039917, 3294.0, 4549.47681016684, 4556.567126123013, 4558.407407037097, 4560.657950653715, 4573.153966516205, 4139.648129908961, 4151.356539736345, 4152.190322887038, 4154.252234597771, 4156.646685031776, 4660.813567457298, 4825.20384136617, 4828.251620998751, 4830.154722923475, 4837.927431088537, 3417.9658203418144, 3418.572678415198, 3432.4508078707286, 3435.7766745161734, 3444.4144495435835, 5121.82073627425, 5129.692218466904, 5141.871453213662, 5150.896982060338, 5173.611979101544, 3440.6559344065895, 3500.334936362083, 3516.2440075383915, 3546.627604101584, 3563.2160924597065, 3565.2512972275595, 3572.5891522474726, 3575.2313252650283, 3586.605473397924, 3593.9281214375565, 4108.650764684976, 4122.6083522065355, 4135.31767258399, 4143.523494798137, 4148.979255103705, 4656.348111264426, 4708.576228139484, 4794.161021821237, 4854.0, 4923.359963204761, 1217.9269243845397, 1230.4893469210178, 1234.481517762542, 1236.758832027764, 1240.4046057892263, 763.5876626621562, 785.3285440948022, 790.1940021178366, 791.8257983243677, 802.4102284820652, 3954.426608141803, 3972.82122304497, 3978.622030907059, 3982.5021872265966, 3986.3023970804993, 4447.086563823815, 4454.665900057444, 4456.821727130879, 4472.977635111869, 4477.440319960005, 3945.3095708251517, 3951.7036222283446, 3982.303096958021, 3986.3092412621363, 3988.6637976277693, 2278.259565641173, 2357.7760112789256, 2377.3699969508093, 2379.3575734551573, 2395.4788709169457, 4256.616904478612, 4278.7004909656025, 4278.743275403485, 4294.398784170218, 4302.311630139163, 4550.226461501553, 4568.497465278817, 4575.695926660886, 4600.815967361335, 4616.653750968623, 4040.070783719761, 4236.4704411948505, 4261.634792690087, 4263.637590804817, 4279.165562715303, 4335.349697545394, 4410.625096866674, 4426.1369033038245, 4453.487848897418, 4504.234280172313, 4397.31841564558, 4409.338599210144, 4426.683983116436, 4431.224535706303, 4433.0, 4079.653229475528, 4185.497740271187, 4266.957330426781, 4285.721428107163, 4318.654507639319, 3205.423023855635, 3232.3858466891215, 3233.690355406064, 3233.8221397822404, 3237.579114715072, 4437.511873693956, 4476.350929115325, 4502.887427814331, 4506.9633984183165, 4857.781399836945, 4721.409823772028, 4854.80580776765, 4895.70263880065, 4936.308916751729, 4962.950370496394, 4893.73084480357, 4896.804127834846, 4905.0, 4912.975435122801, 4917.188663870421, 4612.815487380467, 4827.179379505422, 4828.179209534458, 4852.466228714768, 4869.831240502324, 4964.429090654621, 4965.4289756677, 4980.252962055721, 4990.276409920614, 4995.550400463976, 4877.731724755173, 4881.194602890625, 4885.853424397274, 4889.535494128052, 4890.266460031024], "value": 3550.6658617113926, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.6779465031354, 632.9177206963094, 699.4788882282697, 714.6641078693012, 717.9634861446947, 13012.674683132926, 14063.29683515824, 14158.079724817879, 14165.504207352744, 14192.787108193384, 12896.226226426397, 13095.410706518205, 13524.661883452894, 13649.863501364984, 13707.725845483084, 617.102116420607, 756.9924300756991, 779.7699678594828, 784.8194915169514, 786.1509569664777, 640.7116797441147, 765.418282105601, 791.4815795653856, 796.1202870827739, 799.2167675677839, 825.413956091176, 827.3298628111249, 829.4069740135802, 829.7925518620345, 830.2361827119034, 639.1371648274838, 658.9670516474205, 820.5897051474263, 821.4003777242586, 822.1572887790003, 488.65793944239175, 488.8509004753549, 489.23190590772504, 576.5387689848104, 594.5303210463728, 11772.352520611363, 11774.234674746114, 11780.116491263103, 11831.171817972745, 11842.111841611828, 12279.0, 12528.123031387806, 12589.433475493624, 12886.54897078607, 13170.001388090164, 9498.810023799555, 9733.951330243373, 11071.391073490955, 11071.72320691989, 11162.832557511563, 4075.8981025474304, 4122.216778812016, 4150.086980864236, 4221.261279276145, 4322.978385108086, 42292.78853605743, 43858.780706096586, 43961.78019109916, 44012.779936100436, 44085.11829763387, 10063.39619622825, 10335.0, 10354.585816567253, 10505.107065899332, 10560.683179504627, 18407.171677274553, 18466.169022394024, 18469.445916622524, 18493.16780744843, 18510.16704248312, 6451.709673064724, 6479.967600161969, 6487.286398496161, 6537.509686773511, 6675.399214070757, 3490.8433639216682, 3521.7006554442646, 3546.2730140321173, 3550.396432606463, 3574.7318951078773, 2884.7980641355325, 2990.357073229266, 3007.248187953012, 3008.4584774740756, 3015.5627434021944, 485.55086544945783, 492.61575970742877, 496.6945328622871, 497.41553674432396, 498.4741098141423, 485.56299330602036, 541.0828645445931, 548.6050043968337, 585.3736501942965, 596.1623918394575, 7840.13758486566, 8053.6778528858185, 8204.138565450661, 8409.075001749803, 8413.489164597198, 465.853256224295, 522.4488164985901, 553.510143522977, 586.9652218165286, 618.9597676151036, 3742.62573742629, 3888.300105980894, 3911.5264237686674, 4004.299247631711, 4055.6755459563165, 52642.47357526376, 88042.1195788034, 93928.0, 96652.0, 96919.0, 48996.77508062327, 81456.59271703722, 86143.0, 86628.0, 87014.0, 45091.77454112709, 65850.67074664596, 73771.63114184394, 73839.55486899432, 74143.25856741364, 7396.889046664412, 7491.962540187482, 7721.305082542598, 7788.221177882167, 7955.2840244378285, 46199.30701039554, 47107.29339059985, 47380.2892956599, 47806.521934780205, 48805.5119448801, 37314.0, 46739.766301168274, 51393.743031284605, 53151.25735393339, 57957.71021144867, 10814.459277036274, 11361.808618510926, 11652.592159274385, 11830.05359571215, 11842.703932401759, 12978.480860765463, 13300.201987880759, 13363.26502042397, 13861.514846980308, 14123.435062597791, 10721.30311529748, 11018.228723989243, 11316.15128865355, 11318.26431281964, 11333.943330283295, 11600.419979001184, 12142.696432589257, 12743.299118548199, 13051.412686428943, 13181.538646147339, 10346.586136554453, 10347.94826025865, 10397.636082737068, 10622.468876555986, 11368.147388946027, 10048.49757512136, 10091.697249082246, 10137.0, 10165.644202452879, 10446.947765261126, 9048.638054477748, 9083.273338132802, 9109.225715813966, 9245.72262832116, 9436.622535098519], "value": 6337.722287720095, "unit": "score"}], "name": "dromaeo_css", "value": 6194.662442720625, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 115.0, 114.0, 115.0, 114.0, 117.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 127.0, 168.0, 134.0, 132.0, 136.0, 129.0, 164.0, 129.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 163.0, 163.0, 162.0, 161.0, 162.0, 160.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 76.0, 77.0, 78.0, 76.0, 111.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 110.0, 83.0, 85.0, 83.0, 108.0, 84.0, 84.0, 124.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 118.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 66.0, 68.0, 67.0, 67.0, 66.0, 74.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 93.0, 83.0, 88.0, 83.0, 84.0, 88.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 139.0, 140.0, 139.0, 140.0, 142.0, 156.0, 190.0, 140.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 180.0, 183.0, 182.0, 177.0, 177.0, 175.0, 175.0, 175.0, 173.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 78.0, 73.0, 70.0, 70.0, 69.0, 69.0, 70.0, 72.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1567.2999999999997, "alertThreshold": 2.0}]} 04:41:42 INFO - Return code: 0 04:41:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:41:42 INFO - # TBPL SUCCESS # 04:41:42 INFO - Running post-action listener: _resource_record_post_action 04:41:42 INFO - [mozharness: 2016-10-12 11:41:42.417347Z] Finished run-tests step (success) 04:41:42 INFO - Running post-run listener: _resource_record_post_run 04:41:42 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 410017792; Read time: 20; Write time: 219220 04:41:42 INFO - TinderboxPrint: CPU usage
13.1% 04:41:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:41:42 INFO - TinderboxPrint: I/O write bytes / time
410,017,792 / 219,220 04:41:42 INFO - TinderboxPrint: CPU idle
8,340.0 (86.9%) 04:41:42 INFO - TinderboxPrint: CPU user
1,209.1 (12.6%) 04:41:42 INFO - TinderboxPrint: Swap in / out
0 / 0 04:41:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 116105216; Read time: 0; Write time: 58044 04:41:42 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293011456; Read time: 0; Write time: 161148 04:41:43 INFO - Running post-run listener: _upload_blobber_files 04:41:43 INFO - Blob upload gear active. 04:41:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:43 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 04:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:41:43 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:41:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:41:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:44 INFO - (blobuploader) - INFO - Done attempting. 04:41:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:41:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:41:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:44 INFO - (blobuploader) - INFO - Done attempting. 04:41:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:41:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:41:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:48 INFO - (blobuploader) - INFO - Done attempting. 04:41:48 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:48 INFO - Return code: 0 04:41:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab07984cec8ebc4785f754f4cce873d8219a6cb246c6bc6287f516aa8502bd0bf63254fc14efd60670d017752b620cb6891c44853871bf6baa8f24fa5b009e70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c9f5df1e4c044f052e3ba545d85ca0b8816687f78e8c23c59fa86c1b28bbb25c9b406b7573d5ea1011c18379e9c02fa711f473cca524a9a78b976dfea679b4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cabe4266c1dbb811765acd905a9e86fc9773f5622067fa8443c73d6c4b59fb82fed9c75abcf8c1c2a6802b94e8bbea39319fa44d24ce8d48dedbaab853ccfee2"} 04:41:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:48 INFO - Contents: 04:41:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab07984cec8ebc4785f754f4cce873d8219a6cb246c6bc6287f516aa8502bd0bf63254fc14efd60670d017752b620cb6891c44853871bf6baa8f24fa5b009e70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c9f5df1e4c044f052e3ba545d85ca0b8816687f78e8c23c59fa86c1b28bbb25c9b406b7573d5ea1011c18379e9c02fa711f473cca524a9a78b976dfea679b4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cabe4266c1dbb811765acd905a9e86fc9773f5622067fa8443c73d6c4b59fb82fed9c75abcf8c1c2a6802b94e8bbea39319fa44d24ce8d48dedbaab853ccfee2"} 04:41:48 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:48 INFO - Copying logs to upload dir... 04:41:48 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.486335 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-12 04:41:47.742969) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 04:41:47.747534) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab07984cec8ebc4785f754f4cce873d8219a6cb246c6bc6287f516aa8502bd0bf63254fc14efd60670d017752b620cb6891c44853871bf6baa8f24fa5b009e70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c9f5df1e4c044f052e3ba545d85ca0b8816687f78e8c23c59fa86c1b28bbb25c9b406b7573d5ea1011c18379e9c02fa711f473cca524a9a78b976dfea679b4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cabe4266c1dbb811765acd905a9e86fc9773f5622067fa8443c73d6c4b59fb82fed9c75abcf8c1c2a6802b94e8bbea39319fa44d24ce8d48dedbaab853ccfee2"} build_url:https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/DNZ_UYfZTEGultruzx30bA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab07984cec8ebc4785f754f4cce873d8219a6cb246c6bc6287f516aa8502bd0bf63254fc14efd60670d017752b620cb6891c44853871bf6baa8f24fa5b009e70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1c9f5df1e4c044f052e3ba545d85ca0b8816687f78e8c23c59fa86c1b28bbb25c9b406b7573d5ea1011c18379e9c02fa711f473cca524a9a78b976dfea679b4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cabe4266c1dbb811765acd905a9e86fc9773f5622067fa8443c73d6c4b59fb82fed9c75abcf8c1c2a6802b94e8bbea39319fa44d24ce8d48dedbaab853ccfee2"}' ========= master_lag: 0.48 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 04:41:48.239954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:41:48.240348) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476270106.965067-1695995386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:41:48.257242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 04:41:48.257549) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 04:41:48.257833) ========= ========= Total master_lag: 0.77 =========