builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1480351976.95 results: success (0) buildid: 20161128073657 builduid: 7669bf1a31e249da9828d0a065e2c7dd revision: 2594b001d7579e04a9e01e0fc1cd8512311d4b46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:56.952967) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:56.953386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:56.953693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:56.968636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:56.968976) ========= 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=cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-28 08:52:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.5M=0s 2016-11-28 08:52:58 (65.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093168 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:57.076370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:57.076709) ========= 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=cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:57.127579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:57.127937) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2594b001d7579e04a9e01e0fc1cd8512311d4b46 --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 2594b001d7579e04a9e01e0fc1cd8512311d4b46 --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=cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-28 08:52:58,251 truncating revision to first 12 chars 2016-11-28 08:52:58,251 Setting DEBUG logging. 2016-11-28 08:52:58,251 attempt 1/10 2016-11-28 08:52:58,251 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2594b001d757?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 08:52:58,778 unpacking tar archive at: mozilla-central-2594b001d757/testing/mozharness/ program finished with exit code 0 elapsedTime=0.846106 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:57.992403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:57.992744) ========= script_repo_revision: 2594b001d7579e04a9e01e0fc1cd8512311d4b46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:57.993246) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:57.993528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 08:52:58.004648) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-28 08:52:58.004967) ========= /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=cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:52:59 INFO - MultiFileLogger online at 20161128 08:52:59 in /builds/slave/test 08:52:59 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 08:52:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:59 INFO - {'append_to_log': False, 08:52:59 INFO - 'base_work_dir': '/builds/slave/test', 08:52:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:52:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:59 INFO - 'branch': 'Firefox-Non-PGO', 08:52:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:59 INFO - 'config_files': ('talos/linux_config.py',), 08:52:59 INFO - 'default_actions': ('clobber', 08:52:59 INFO - 'read-buildbot-config', 08:52:59 INFO - 'download-and-extract', 08:52:59 INFO - 'populate-webroot', 08:52:59 INFO - 'create-virtualenv', 08:52:59 INFO - 'install', 08:52:59 INFO - 'run-tests'), 08:52:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:59 INFO - 'download_minidump_stackwalk': True, 08:52:59 INFO - 'download_symbols': 'ondemand', 08:52:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:59 INFO - 'installer_path': 'installer.exe', 08:52:59 INFO - 'log_level': 'info', 08:52:59 INFO - 'log_name': 'talos', 08:52:59 INFO - 'log_to_console': True, 08:52:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:52:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:52:59 INFO - 'opt_config_files': (), 08:52:59 INFO - 'pip_index': False, 08:52:59 INFO - 'sps_profile': False, 08:52:59 INFO - 'sps_profile_interval': 0, 08:52:59 INFO - 'suite': 'dromaeojs', 08:52:59 INFO - 'system_bits': '32', 08:52:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:59 INFO - 'title': 'talos-linux64-ix-054', 08:52:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:59 INFO - 'use_talos_json': True, 08:52:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:59 INFO - 'work_dir': 'build'} 08:52:59 INFO - [mozharness: 2016-11-28 16:52:59.221677Z] Running clobber step. 08:52:59 INFO - Running pre-action listener: _resource_record_pre_action 08:52:59 INFO - Running main action method: clobber 08:52:59 INFO - rmtree: /builds/slave/test/build 08:52:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:00 INFO - Running post-action listener: _resource_record_post_action 08:53:00 INFO - [mozharness: 2016-11-28 16:53:00.204892Z] Finished clobber step (success) 08:53:00 INFO - [mozharness: 2016-11-28 16:53:00.204990Z] Running read-buildbot-config step. 08:53:00 INFO - Running pre-action listener: _resource_record_pre_action 08:53:00 INFO - Running main action method: read_buildbot_config 08:53:00 INFO - Using buildbot properties: 08:53:00 INFO - { 08:53:00 INFO - "project": "", 08:53:00 INFO - "product": "firefox", 08:53:00 INFO - "script_repo_revision": "production", 08:53:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:53:00 INFO - "repository": "", 08:53:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:53:00 INFO - "buildid": "20161128073657", 08:53:00 INFO - "pgo_build": "False", 08:53:00 INFO - "basedir": "/builds/slave/test", 08:53:00 INFO - "buildnumber": 312, 08:53:00 INFO - "slavename": "talos-linux64-ix-054", 08:53:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:53:00 INFO - "platform": "ubuntu64_hw", 08:53:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:53:00 INFO - "branch": "mozilla-central", 08:53:00 INFO - "repo_path": "mozilla-central", 08:53:00 INFO - "revision": "2594b001d7579e04a9e01e0fc1cd8512311d4b46", 08:53:00 INFO - "stage_platform": "linux64", 08:53:00 INFO - "builduid": "7669bf1a31e249da9828d0a065e2c7dd", 08:53:00 INFO - "slavebuilddir": "test" 08:53:00 INFO - } 08:53:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:53:00 INFO - Running post-action listener: _resource_record_post_action 08:53:00 INFO - [mozharness: 2016-11-28 16:53:00.207681Z] Finished read-buildbot-config step (success) 08:53:00 INFO - [mozharness: 2016-11-28 16:53:00.207770Z] Running download-and-extract step. 08:53:00 INFO - Running pre-action listener: _resource_record_pre_action 08:53:00 INFO - Running main action method: download_and_extract 08:53:00 INFO - mkdir: /builds/slave/test/build/tests 08:53:00 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')]} 08:53:00 INFO - trying https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:53:00 INFO - Downloading https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:53:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:53:00 INFO - Downloaded 1361 bytes. 08:53:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:53:00 INFO - Using the following test package requirements: 08:53:00 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:53:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:53:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:00 INFO - u'jsshell-linux-x86_64.zip'], 08:53:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:53:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:53:00 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:53:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:53:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:53:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:53:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:53:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:53:00 INFO - Fetch https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:53:01 INFO - Http code: 200 08:53:01 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 08:53:01 INFO - x-amz-cf-id: 3RB41KVc2z4S4hLLe2ohQyEk5VzUpQUfI5lb01HH5fgS6E8zeZqtRw== 08:53:01 INFO - x-amz-version-id: s1V4.s2TfGH3NbSmVKmrAcK46iRkgHIc 08:53:01 INFO - Expected file size: 20217408 08:53:01 INFO - Obtained file size: 20217408 08:53:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:53:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:53:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:53:05 INFO - Fetch https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:53:06 INFO - Http code: 200 08:53:06 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 08:53:06 INFO - x-amz-cf-id: OrSGtuQd9lUKhWfVV5rvemguaUf-NiN1vbTBlqKvWKQa7N-AOXLmIw== 08:53:06 INFO - x-amz-version-id: s1V4.s2TfGH3NbSmVKmrAcK46iRkgHIc 08:53:06 INFO - Expected file size: 20217408 08:53:06 INFO - Obtained file size: 20217408 08:53:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:53:10 INFO - Fetch https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:53:11 INFO - Http code: 200 08:53:11 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 08:53:11 INFO - x-amz-cf-id: Tx3LD22hvhTJQyuMEirwbzRVJlbcB-7zE8tC22L7y6sGftDYvTva9g== 08:53:11 INFO - x-amz-version-id: XNHAfMY_lQeeRxRIG_tvLt8ls5CAz.t6 08:53:12 INFO - Expected file size: 14409702 08:53:12 INFO - Obtained file size: 14409702 08:53:12 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')]} 08:53:12 INFO - trying https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:53:12 INFO - Downloading https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:53:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:53:14 INFO - Downloaded 55673438 bytes. 08:53:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:53:14 INFO - mkdir: /builds/slave/test/properties 08:53:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:14 INFO - Contents: 08:53:14 INFO - build_url:https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:53:15 INFO - Running post-action listener: _resource_record_post_action 08:53:15 INFO - Running post-action listener: set_extra_try_arguments 08:53:15 INFO - [mozharness: 2016-11-28 16:53:15.594016Z] Finished download-and-extract step (success) 08:53:15 INFO - [mozharness: 2016-11-28 16:53:15.594243Z] Running populate-webroot step. 08:53:15 INFO - Running pre-action listener: _resource_record_pre_action 08:53:15 INFO - Running main action method: populate_webroot 08:53:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:15 INFO - '--tppagecycles', 08:53:15 INFO - '7'], 08:53:15 INFO - 'tests': ['tsvgm']}}, 08:53:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:53:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['damp', 'tps']}, 08:53:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:53:15 INFO - 'tests': ['damp', 'tps']}, 08:53:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['dromaeo_dom']}, 08:53:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['basic_compositor_video']}, 08:53:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:53:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tsvgx', 08:53:15 INFO - 'tsvgr_opacity', 08:53:15 INFO - 'tart', 08:53:15 INFO - 'tscrollx', 08:53:15 INFO - 'cart', 08:53:15 INFO - 'tsvg_static']}, 08:53:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:15 INFO - 'tsvgr_opacity', 08:53:15 INFO - 'tart', 08:53:15 INFO - 'tscrollx', 08:53:15 INFO - 'cart', 08:53:15 INFO - 'tsvg_static']}, 08:53:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tp5o']}, 08:53:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:53:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s', 08:53:15 INFO - '--xperf_path', 08:53:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:15 INFO - 'tests': ['tp5n']}, 08:53:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:53:15 INFO - 'talos_options': ['--xperf_path', 08:53:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:15 INFO - 'tests': ['tp5n']}}, 08:53:15 INFO - 'talos.zip': {'path': '', 08:53:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:15 INFO - Running post-action listener: _resource_record_post_action 08:53:15 INFO - [mozharness: 2016-11-28 16:53:15.609625Z] Finished populate-webroot step (success) 08:53:15 INFO - [mozharness: 2016-11-28 16:53:15.609713Z] Running create-virtualenv step. 08:53:15 INFO - Running pre-action listener: _resource_record_pre_action 08:53:15 INFO - Running main action method: create_virtualenv 08:53:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:15 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 08:53:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:15 INFO - Using real prefix '/usr' 08:53:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:18 INFO - Installing pip.................done. 08:53:18 INFO - Return code: 0 08:53:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:53:18 INFO - Reading from file tmpfile_stdout 08:53:18 INFO - Output received: 08:53:18 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) 08:53:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe25f86e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, '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': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', '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 08:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:53:18 INFO - Using env: {'DISPLAY': ':0', 08:53:18 INFO - 'HOME': '/home/cltbld', 08:53:18 INFO - 'LANG': 'en_US.UTF-8', 08:53:18 INFO - 'LANGUAGE': 'en_US:en', 08:53:18 INFO - 'LOGNAME': 'cltbld', 08:53:18 INFO - 'MAIL': '/var/mail/cltbld', 08:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:18 INFO - 'MOZ_NO_REMOTE': '1', 08:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:18 INFO - 'NO_EM_RESTART': '1', 08:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:18 INFO - 'PWD': '/builds/slave/test', 08:53:18 INFO - 'SHELL': '/bin/bash', 08:53:18 INFO - 'SHLVL': '1', 08:53:18 INFO - 'TERM': 'linux', 08:53:18 INFO - 'TMOUT': '86400', 08:53:18 INFO - 'USER': 'cltbld', 08:53:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:18 INFO - '_': '/tools/buildbot/bin/python'} 08:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:18 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 08:53:18 INFO - Cleaning up... 08:53:18 INFO - Return code: 0 08:53:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe25f86e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, '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': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', '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 08:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:53:18 INFO - Using env: {'DISPLAY': ':0', 08:53:18 INFO - 'HOME': '/home/cltbld', 08:53:18 INFO - 'LANG': 'en_US.UTF-8', 08:53:18 INFO - 'LANGUAGE': 'en_US:en', 08:53:18 INFO - 'LOGNAME': 'cltbld', 08:53:18 INFO - 'MAIL': '/var/mail/cltbld', 08:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:18 INFO - 'MOZ_NO_REMOTE': '1', 08:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:18 INFO - 'NO_EM_RESTART': '1', 08:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:18 INFO - 'PWD': '/builds/slave/test', 08:53:18 INFO - 'SHELL': '/bin/bash', 08:53:18 INFO - 'SHLVL': '1', 08:53:18 INFO - 'TERM': 'linux', 08:53:18 INFO - 'TMOUT': '86400', 08:53:18 INFO - 'USER': 'cltbld', 08:53:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:18 INFO - '_': '/tools/buildbot/bin/python'} 08:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:18 INFO - Downloading/unpacking psutil>=3.1.1 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:21 INFO - Installing collected packages: psutil 08:53:21 INFO - Running setup.py install for psutil 08:53:21 INFO - building 'psutil._psutil_linux' extension 08:53: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 08:53: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 08:53:21 INFO - building 'psutil._psutil_posix' extension 08:53: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 08:53: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:53:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:21 INFO - Successfully installed psutil 08:53:21 INFO - Cleaning up... 08:53:21 INFO - Return code: 0 08:53:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:21 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 0x7ffe25f86e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, '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': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', '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 08:53:21 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 08:53:21 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 08:53:21 INFO - Using env: {'DISPLAY': ':0', 08:53:21 INFO - 'HOME': '/home/cltbld', 08:53:21 INFO - 'LANG': 'en_US.UTF-8', 08:53:21 INFO - 'LANGUAGE': 'en_US:en', 08:53:21 INFO - 'LOGNAME': 'cltbld', 08:53:21 INFO - 'MAIL': '/var/mail/cltbld', 08:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:21 INFO - 'MOZ_NO_REMOTE': '1', 08:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:21 INFO - 'NO_EM_RESTART': '1', 08:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:21 INFO - 'PWD': '/builds/slave/test', 08:53:21 INFO - 'SHELL': '/bin/bash', 08:53:21 INFO - 'SHLVL': '1', 08:53:21 INFO - 'TERM': 'linux', 08:53:21 INFO - 'TMOUT': '86400', 08:53:21 INFO - 'USER': 'cltbld', 08:53:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:21 INFO - '_': '/tools/buildbot/bin/python'} 08:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53:21 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 08:53:21 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 08:53:21 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 08:53:21 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 08:53:21 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 08:53:21 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 08:53:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:23 INFO - Installing collected packages: mozsystemmonitor 08:53:23 INFO - Running setup.py install for mozsystemmonitor 08:53:24 INFO - Successfully installed mozsystemmonitor 08:53:24 INFO - Cleaning up... 08:53:24 INFO - Return code: 0 08:53:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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 0x7ffe25f86e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, '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': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', '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 08:53: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 08:53: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 08:53:24 INFO - Using env: {'DISPLAY': ':0', 08:53:24 INFO - 'HOME': '/home/cltbld', 08:53:24 INFO - 'LANG': 'en_US.UTF-8', 08:53:24 INFO - 'LANGUAGE': 'en_US:en', 08:53:24 INFO - 'LOGNAME': 'cltbld', 08:53:24 INFO - 'MAIL': '/var/mail/cltbld', 08:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:24 INFO - 'MOZ_NO_REMOTE': '1', 08:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:24 INFO - 'NO_EM_RESTART': '1', 08:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:24 INFO - 'PWD': '/builds/slave/test', 08:53:24 INFO - 'SHELL': '/bin/bash', 08:53:24 INFO - 'SHLVL': '1', 08:53:24 INFO - 'TERM': 'linux', 08:53:24 INFO - 'TMOUT': '86400', 08:53:24 INFO - 'USER': 'cltbld', 08:53:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:24 INFO - '_': '/tools/buildbot/bin/python'} 08:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:24 INFO - Downloading/unpacking jsonschema==2.5.1 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:26 INFO - warning: no files found matching '*.txt' 08:53:26 INFO - no previously-included directories found matching 'build' 08:53:26 INFO - no previously-included directories found matching 'dist' 08:53:26 INFO - no previously-included directories found matching '.git*' 08:53:26 INFO - Installing collected packages: jsonschema, functools32 08:53:26 INFO - Running setup.py install for functools32 08:53:26 INFO - warning: no files found matching '*.txt' 08:53:26 INFO - no previously-included directories found matching 'build' 08:53:26 INFO - no previously-included directories found matching 'dist' 08:53:26 INFO - no previously-included directories found matching '.git*' 08:53:26 INFO - Successfully installed jsonschema functools32 08:53:26 INFO - Cleaning up... 08:53:26 INFO - Return code: 0 08:53:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe25f86e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, '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': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', '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 08:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:53:26 INFO - Using env: {'DISPLAY': ':0', 08:53:26 INFO - 'HOME': '/home/cltbld', 08:53:26 INFO - 'LANG': 'en_US.UTF-8', 08:53:26 INFO - 'LANGUAGE': 'en_US:en', 08:53:26 INFO - 'LOGNAME': 'cltbld', 08:53:26 INFO - 'MAIL': '/var/mail/cltbld', 08:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:26 INFO - 'MOZ_NO_REMOTE': '1', 08:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:26 INFO - 'NO_EM_RESTART': '1', 08:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:26 INFO - 'PWD': '/builds/slave/test', 08:53:26 INFO - 'SHELL': '/bin/bash', 08:53:26 INFO - 'SHLVL': '1', 08:53:26 INFO - 'TERM': 'linux', 08:53:26 INFO - 'TMOUT': '86400', 08:53:26 INFO - 'USER': 'cltbld', 08:53:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:26 INFO - '_': '/tools/buildbot/bin/python'} 08:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:53:27 INFO - Cleaning up... 08:53:27 INFO - Return code: 0 08:53:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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 0x7ffe25f86e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, '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': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', '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 08:53: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 08:53: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 08:53:27 INFO - Using env: {'DISPLAY': ':0', 08:53:27 INFO - 'HOME': '/home/cltbld', 08:53:27 INFO - 'LANG': 'en_US.UTF-8', 08:53:27 INFO - 'LANGUAGE': 'en_US:en', 08:53:27 INFO - 'LOGNAME': 'cltbld', 08:53:27 INFO - 'MAIL': '/var/mail/cltbld', 08:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:27 INFO - 'MOZ_NO_REMOTE': '1', 08:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:27 INFO - 'NO_EM_RESTART': '1', 08:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:27 INFO - 'PWD': '/builds/slave/test', 08:53:27 INFO - 'SHELL': '/bin/bash', 08:53:27 INFO - 'SHLVL': '1', 08:53:27 INFO - 'TERM': 'linux', 08:53:27 INFO - 'TMOUT': '86400', 08:53:27 INFO - 'USER': 'cltbld', 08:53:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:27 INFO - '_': '/tools/buildbot/bin/python'} 08:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:29 INFO - Downloading docopt-0.6.1.tar.gz 08:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:30 INFO - Running setup.py install for blobuploader 08:53:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:30 INFO - Running setup.py install for requests 08:53:30 INFO - Running setup.py install for docopt 08:53:30 INFO - Successfully installed blobuploader requests docopt 08:53:30 INFO - Cleaning up... 08:53:30 INFO - Return code: 0 08:53:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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 0x7ffe25f86e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, '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': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', '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 08:53: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 08:53: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 08:53:30 INFO - Using env: {'DISPLAY': ':0', 08:53:30 INFO - 'HOME': '/home/cltbld', 08:53:30 INFO - 'LANG': 'en_US.UTF-8', 08:53:30 INFO - 'LANGUAGE': 'en_US:en', 08:53:30 INFO - 'LOGNAME': 'cltbld', 08:53:30 INFO - 'MAIL': '/var/mail/cltbld', 08:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:30 INFO - 'MOZ_NO_REMOTE': '1', 08:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:30 INFO - 'NO_EM_RESTART': '1', 08:53:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:30 INFO - 'PWD': '/builds/slave/test', 08:53:30 INFO - 'SHELL': '/bin/bash', 08:53:30 INFO - 'SHLVL': '1', 08:53:30 INFO - 'TERM': 'linux', 08:53:30 INFO - 'TMOUT': '86400', 08:53:30 INFO - 'USER': 'cltbld', 08:53:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:30 INFO - '_': '/tools/buildbot/bin/python'} 08:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:30 INFO - Running setup.py (path:/tmp/pip-NzAsL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:30 INFO - Running setup.py (path:/tmp/pip-Kl7DO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:31 INFO - Running setup.py (path:/tmp/pip-oTqxjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:31 INFO - Running setup.py (path:/tmp/pip-oiiUbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:31 INFO - Running setup.py (path:/tmp/pip-nmW2N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:31 INFO - Running setup.py (path:/tmp/pip-qYC8A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:31 INFO - Running setup.py (path:/tmp/pip-s0zdMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:31 INFO - Running setup.py (path:/tmp/pip-rOTrCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:31 INFO - Running setup.py (path:/tmp/pip-NzQbhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:31 INFO - Running setup.py (path:/tmp/pip-9GVCYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:31 INFO - Running setup.py (path:/tmp/pip-tB1pFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:31 INFO - Running setup.py (path:/tmp/pip-vWwyu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:31 INFO - Running setup.py (path:/tmp/pip-U7L8C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:31 INFO - Running setup.py (path:/tmp/pip-7tAETV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:31 INFO - Running setup.py (path:/tmp/pip-W9l_xC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:31 INFO - Running setup.py (path:/tmp/pip-MGbVCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:32 INFO - Running setup.py (path:/tmp/pip-HkTid0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:32 INFO - Running setup.py install for manifestparser 08:53:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:32 INFO - Running setup.py install for mozcrash 08:53:32 INFO - Running setup.py install for mozdebug 08:53:32 INFO - Running setup.py install for mozdevice 08:53:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:32 INFO - Running setup.py install for mozfile 08:53:32 INFO - Running setup.py install for mozhttpd 08:53:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:32 INFO - Running setup.py install for mozinfo 08:53:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:32 INFO - Running setup.py install for mozInstall 08:53:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:32 INFO - Running setup.py install for mozleak 08:53:32 INFO - Running setup.py install for mozlog 08:53:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:33 INFO - Running setup.py install for moznetwork 08:53:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:33 INFO - Running setup.py install for mozprocess 08:53:33 INFO - Running setup.py install for mozprofile 08:53:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:33 INFO - Running setup.py install for mozrunner 08:53:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:33 INFO - Running setup.py install for mozscreenshot 08:53:33 INFO - Running setup.py install for moztest 08:53:33 INFO - Running setup.py install for mozversion 08:53:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:33 INFO - Cleaning up... 08:53:33 INFO - Return code: 0 08:53:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:33 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 0x7ffe25f86e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, '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': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', '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 08:53:33 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 08:53:33 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 08:53:33 INFO - Using env: {'DISPLAY': ':0', 08:53:33 INFO - 'HOME': '/home/cltbld', 08:53:33 INFO - 'LANG': 'en_US.UTF-8', 08:53:33 INFO - 'LANGUAGE': 'en_US:en', 08:53:33 INFO - 'LOGNAME': 'cltbld', 08:53:33 INFO - 'MAIL': '/var/mail/cltbld', 08:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:33 INFO - 'MOZ_NO_REMOTE': '1', 08:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:33 INFO - 'NO_EM_RESTART': '1', 08:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:33 INFO - 'PWD': '/builds/slave/test', 08:53:33 INFO - 'SHELL': '/bin/bash', 08:53:33 INFO - 'SHLVL': '1', 08:53:33 INFO - 'TERM': 'linux', 08:53:33 INFO - 'TMOUT': '86400', 08:53:33 INFO - 'USER': 'cltbld', 08:53:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:33 INFO - '_': '/tools/buildbot/bin/python'} 08:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:34 INFO - Running setup.py (path:/tmp/pip-ybfwjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53: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)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:34 INFO - Running setup.py (path:/tmp/pip-JGjKoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:34 INFO - Running setup.py (path:/tmp/pip-NXIdqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53: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)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:34 INFO - Running setup.py (path:/tmp/pip-5SduWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:34 INFO - Running setup.py (path:/tmp/pip-COoNfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53: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)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:34 INFO - Running setup.py (path:/tmp/pip-N1iiVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53: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)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:34 INFO - Running setup.py (path:/tmp/pip-qyP_Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53: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)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:34 INFO - Running setup.py (path:/tmp/pip-I7GOwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:34 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)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:34 INFO - Running setup.py (path:/tmp/pip-5a3Jqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:34 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)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:34 INFO - Running setup.py (path:/tmp/pip-h9ehG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:34 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)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:34 INFO - Running setup.py (path:/tmp/pip-hWD2mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:34 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)) 08:53:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:34 INFO - Running setup.py (path:/tmp/pip-x5kNbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53: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)) 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:35 INFO - Running setup.py (path:/tmp/pip-6ZJNcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53: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)) 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:35 INFO - Running setup.py (path:/tmp/pip-Pb93nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:35 INFO - Running setup.py (path:/tmp/pip-zdYyux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53: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)) 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:35 INFO - Running setup.py (path:/tmp/pip-GwXrQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53: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)) 08:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:35 INFO - Running setup.py (path:/tmp/pip-NbY_eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53: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)) 08:53: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53: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)) 08:53: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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53: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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:37 INFO - Downloading blessings-1.6.tar.gz 08:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:37 INFO - Installing collected packages: blessings 08:53:37 INFO - Running setup.py install for blessings 08:53:37 INFO - Successfully installed blessings 08:53:37 INFO - Cleaning up... 08:53:37 INFO - Return code: 0 08:53:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:37 INFO - Reading from file tmpfile_stdout 08:53:37 INFO - Current package versions: 08:53:37 INFO - argparse == 1.2.1 08:53:37 INFO - blessings == 1.6 08:53:37 INFO - blobuploader == 1.2.4 08:53:37 INFO - docopt == 0.6.1 08:53:37 INFO - functools32 == 3.2.3-2 08:53:37 INFO - jsonschema == 2.5.1 08:53:37 INFO - manifestparser == 1.1 08:53:37 INFO - mozInstall == 1.12 08:53:37 INFO - mozcrash == 1.0 08:53:37 INFO - mozdebug == 0.1 08:53:37 INFO - mozdevice == 0.49 08:53:37 INFO - mozfile == 1.2 08:53:37 INFO - mozhttpd == 0.7 08:53:37 INFO - mozinfo == 0.9 08:53:37 INFO - mozleak == 0.1 08:53:37 INFO - mozlog == 3.4 08:53:37 INFO - moznetwork == 0.27 08:53:37 INFO - mozprocess == 0.23 08:53:37 INFO - mozprofile == 0.28 08:53:37 INFO - mozrunner == 6.13 08:53:37 INFO - mozscreenshot == 0.1 08:53:37 INFO - mozsystemmonitor == 0.3 08:53:37 INFO - moztest == 0.7 08:53:37 INFO - mozversion == 1.4 08:53:37 INFO - psutil == 3.1.1 08:53:37 INFO - requests == 1.2.3 08:53:37 INFO - wsgiref == 0.1.2 08:53:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:37 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')]} 08:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:37 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')]} 08:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:37 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 0x7ffe25f86e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, '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': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', '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 08:53:37 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 08:53:37 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 08:53:37 INFO - Using env: {'DISPLAY': ':0', 08:53:37 INFO - 'HOME': '/home/cltbld', 08:53:37 INFO - 'LANG': 'en_US.UTF-8', 08:53:37 INFO - 'LANGUAGE': 'en_US:en', 08:53:37 INFO - 'LOGNAME': 'cltbld', 08:53:37 INFO - 'MAIL': '/var/mail/cltbld', 08:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:37 INFO - 'MOZ_NO_REMOTE': '1', 08:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:37 INFO - 'NO_EM_RESTART': '1', 08:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:37 INFO - 'PWD': '/builds/slave/test', 08:53:37 INFO - 'SHELL': '/bin/bash', 08:53:37 INFO - 'SHLVL': '1', 08:53:37 INFO - 'TERM': 'linux', 08:53:37 INFO - 'TMOUT': '86400', 08:53:37 INFO - 'USER': 'cltbld', 08:53:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:37 INFO - '_': '/tools/buildbot/bin/python'} 08:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53: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)) 08:53: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)) 08:53: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)) 08:53: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)) 08:53: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)) 08:53: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)) 08:53: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)) 08:53: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)) 08:53: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)) 08:53: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)) 08:53: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)) 08:53:38 INFO - Cleaning up... 08:53:38 INFO - Return code: 0 08:53:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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 0x7ffe25f86e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e1b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, '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': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', '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 08:53: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 08:53: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 08:53:38 INFO - Using env: {'DISPLAY': ':0', 08:53:38 INFO - 'HOME': '/home/cltbld', 08:53:38 INFO - 'LANG': 'en_US.UTF-8', 08:53:38 INFO - 'LANGUAGE': 'en_US:en', 08:53:38 INFO - 'LOGNAME': 'cltbld', 08:53:38 INFO - 'MAIL': '/var/mail/cltbld', 08:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:38 INFO - 'MOZ_NO_REMOTE': '1', 08:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:38 INFO - 'NO_EM_RESTART': '1', 08:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:38 INFO - 'PWD': '/builds/slave/test', 08:53:38 INFO - 'SHELL': '/bin/bash', 08:53:38 INFO - 'SHLVL': '1', 08:53:38 INFO - 'TERM': 'linux', 08:53:38 INFO - 'TMOUT': '86400', 08:53:38 INFO - 'USER': 'cltbld', 08:53:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:38 INFO - '_': '/tools/buildbot/bin/python'} 08:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:38 INFO - Cleaning up... 08:53:38 INFO - Return code: 0 08:53:38 INFO - Running post-action listener: _resource_record_post_action 08:53:38 INFO - Running post-action listener: _start_resource_monitoring 08:53:38 INFO - Starting resource monitoring. 08:53:38 INFO - [mozharness: 2016-11-28 16:53:38.354796Z] Finished create-virtualenv step (success) 08:53:38 INFO - [mozharness: 2016-11-28 16:53:38.355279Z] Running install step. 08:53:38 INFO - Running pre-action listener: _resource_record_pre_action 08:53:38 INFO - Running main action method: install 08:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:38 INFO - Reading from file tmpfile_stdout 08:53:38 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:38 INFO - Reading from file tmpfile_stdout 08:53:38 INFO - Output received: 08:53:38 INFO - Usage: mozinstall [options] installer 08:53:38 INFO - Options: 08:53:38 INFO - -h, --help show this help message and exit 08:53:38 INFO - -d DEST, --destination=DEST 08:53:38 INFO - Directory to install application into. [default: 08:53:38 INFO - "/builds/slave/test"] 08:53:38 INFO - --app=APP Application being installed. [default: firefox] 08:53:38 INFO - mkdir: /builds/slave/test/build/application 08:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:53:54 INFO - Reading from file tmpfile_stdout 08:53:54 INFO - Output received: 08:53:54 INFO - /builds/slave/test/build/application/firefox/firefox 08:53:54 INFO - Running post-action listener: _resource_record_post_action 08:53:54 INFO - [mozharness: 2016-11-28 16:53:54.696100Z] Finished install step (success) 08:53:54 INFO - [mozharness: 2016-11-28 16:53:54.696344Z] Running run-tests step. 08:53:54 INFO - Running pre-action listener: _resource_record_pre_action 08:53:54 INFO - Running main action method: run_tests 08:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:53:54 INFO - Python 2.7.3 08:53:54 INFO - Return code: 0 08:53:54 INFO - grabbing minidump binary from tooltool 08:53:54 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')]} 08:53:54 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 0x250bfc0>, '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 0x250cec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250d350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:53:54 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 08:53:54 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 08:53:54 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 08:53:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:53:54 INFO - Return code: 0 08:53:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:53:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:53:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:53:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:53:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:53:54 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/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 08:53:54 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/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 08:53:54 INFO - Using env: {'DISPLAY': ':0', 08:53:54 INFO - 'HOME': '/home/cltbld', 08:53:54 INFO - 'LANG': 'en_US.UTF-8', 08:53:54 INFO - 'LANGUAGE': 'en_US:en', 08:53:54 INFO - 'LOGNAME': 'cltbld', 08:53:54 INFO - 'MAIL': '/var/mail/cltbld', 08:53:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:53:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:54 INFO - 'MOZ_NO_REMOTE': '1', 08:53:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:54 INFO - 'NO_EM_RESTART': '1', 08:53:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:54 INFO - 'PWD': '/builds/slave/test', 08:53:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:53:54 INFO - 'SHELL': '/bin/bash', 08:53:54 INFO - 'SHLVL': '1', 08:53:54 INFO - 'TERM': 'linux', 08:53:54 INFO - 'TMOUT': '86400', 08:53:54 INFO - 'USER': 'cltbld', 08:53:54 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819', 08:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:54 INFO - '_': '/tools/buildbot/bin/python'} 08:53:54 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/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 08:53:54 INFO - mozversion application_buildid: 20161128073657 08:53:54 INFO - mozversion application_changeset: 2594b001d7579e04a9e01e0fc1cd8512311d4b46 08:53:54 INFO - mozversion application_display_name: Nightly 08:53:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:53:54 INFO - mozversion application_name: Firefox 08:53:54 INFO - mozversion application_remotingname: firefox 08:53:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:53:54 INFO - mozversion application_vendor: Mozilla 08:53:54 INFO - mozversion application_version: 53.0a1 08:53:54 INFO - mozversion platform_buildid: 20161128073657 08:53:54 INFO - mozversion platform_changeset: 2594b001d7579e04a9e01e0fc1cd8512311d4b46 08:53:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:53:54 INFO - mozversion platform_version: 53.0a1 08:53:54 INFO - using testdate: 1480352034 08:53:54 INFO - actual date: 1480352034 08:53:54 INFO - starting webserver on 'localhost:37795' 08:53:54 INFO - SUITE-START | Running 2 tests 08:53:54 INFO - TEST-START | dromaeo_css 08:53:54 INFO - operating with platform_type : linux_ 08:53:54 INFO - Initialising browser for dromaeo_css test... 08:53:54 INFO - TEST-INFO | started process 15253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7DUwrD/profile http://localhost:37795/getInfo.html) 08:53:59 INFO - PROCESS | 15253 | __metrics Screen width/height:1600/1200 08:53:59 INFO - PROCESS | 15253 | colorDepth:24 08:53:59 INFO - PROCESS | 15253 | Browser inner width/height: 1024/697 08:53:59 INFO - PROCESS | 15253 | __metrics 08:54:00 INFO - PROCESS | 15253 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:54:00 INFO - PROCESS | 15253 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:00 INFO - PROCESS | 15253 | console.error: PushService: 08:54:00 INFO - PROCESS | 15253 | stateChangeProcessEnqueue: Error transitioning state 08:54:00 INFO - PROCESS | 15253 | UnknownError 08:54:01 INFO - TEST-INFO | 15253: exit 0 08:54:01 INFO - Browser initialized. 08:54:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:01 INFO - TEST-INFO | started process 15333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7DUwrD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:13 INFO - PROCESS | 15333 | RSS: Main: 174755840 08:54:13 INFO - PROCESS | 15333 | 08:55:05 INFO - PROCESS | 15333 | 1480352105478 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] 08:57:19 INFO - PROCESS | 15333 | Cycle 1(1): loaded http://localhost:37795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37795/tests/dromaeo/cssquery-ext.html) 08:57:21 INFO - PROCESS | 15333 | RSS: Main: 318316544 08:57:21 INFO - PROCESS | 15333 | 09:00:23 INFO - PROCESS | 15333 | Cycle 1(1): loaded http://localhost:37795/tests/dromaeo/cssquery-ext.html (next: http://localhost:37795/tests/dromaeo/cssquery-jquery.html) 09:00:24 INFO - PROCESS | 15333 | RSS: Main: 286801920 09:00:24 INFO - PROCESS | 15333 | 09:03:27 INFO - PROCESS | 15333 | Cycle 1(1): loaded http://localhost:37795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37795/tests/dromaeo/cssquery-mootools.html) 09:03:27 INFO - PROCESS | 15333 | RSS: Main: 252387328 09:03:27 INFO - PROCESS | 15333 | 09:06:30 INFO - PROCESS | 15333 | Cycle 1(1): loaded http://localhost:37795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37795/tests/dromaeo/cssquery-prototype.html) 09:06:30 INFO - PROCESS | 15333 | RSS: Main: 238936064 09:06:30 INFO - PROCESS | 15333 | 09:09:34 INFO - PROCESS | 15333 | Cycle 1(1): loaded http://localhost:37795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37795/tests/dromaeo/cssquery-yui.html) 09:09:34 INFO - PROCESS | 15333 | RSS: Main: 225210368 09:09:34 INFO - PROCESS | 15333 | 09:12:37 INFO - PROCESS | 15333 | Cycle 1(1): loaded http://localhost:37795/tests/dromaeo/cssquery-yui.html (next: http://localhost:37795/tests/dromaeo/cssquery-dojo.html) 09:12:37 INFO - PROCESS | 15333 | RSS: Main: 315228160 09:12:37 INFO - PROCESS | 15333 | 09:12:37 INFO - PROCESS | 15333 | __start_tp_report 09:12:37 INFO - PROCESS | 15333 | _x_x_mozilla_page_load 09:12:37 INFO - PROCESS | 15333 | _x_x_mozilla_page_load_details 09:12:37 INFO - PROCESS | 15333 | |i|pagename|runs| 09:12:37 INFO - PROCESS | 15333 | |0;dojo.html;2573.806964477664;2607.178738697309;2631.868406579671;2636.433166869123;2638.7229340919203;4520.050789334244;4581.518940511249;4627.8380256691025;4679.906401871961;4690.976545117274;4599.586037256646;4617.630589552836;4619;4623.514530974249;4629.0510445358705;4224.091820258652;4247.681423893205;4268.765217913029;4281.272183728758;4290.4851417829905;4314.892127696817;4341.479022517302;4347.847825326115;4356.150550642626;4357.346398040288;4203.159368126372;4218.936715949263;4242.53332133465;4247.171801498709;4350.456192975878;4288.206681763883;4292.098659281554;4295.119500502389;4304.870853874358;4317.740935543861;4146.709730318879;4154.5222299435345;4169.624733773944;4227.957720422818;4261.552536983634;4580.885477863047;4603.056373443436;4605.631549476034;4616.792244349012;4627.930581041287;4921.7785199666105;4932.531409516126;4953.133201689726;4964.280179373971;4991.600671946236;4848.927266091011;4862.17343051682;4969.627277954131;4975.4527002029745;5012.72430016349;4579.610733087725;4580.610648094949;4598.471175814757;4599.471060827981;4599.954000460019;5012.874678133003;5024.145895197752;5025.497450254945;5028.874278143076;5033.47148549397;4849.830255941096;4915;4920.778564964585;4927.482614325444;4927.655064145547;4869.172240719086;4945.159322915113;4947.925781113287;4951.9752401237765;4996.925046124311;4823.131836269506;4864.802921671943;4875.43932447773;4905.9264111038365;4949.876253093701;4741.43102827656;4786.305985632064;4787.066522028241;4842.58837998774;4886.047220791983;4245.87262382129;4247.256730072225;4248.1078973415315;4268.9786551067045;4292.763897985578;3766.133789228493;3768.9434658480145;3771.2268984858038;3773.339665558516;3776.50905382304;4247.405363249148;4272.124214536075;4280.700350975402;4284.100338928797;4290.935635965463;4932.90134197314;4937.333459982857;4948.554630083309;4951.480094590088;4957.553820156203;4249.80875860587;4262.041040765803;4265.680073994463;4266.488021437447;4268.039691069484;4443.866683999485;4456.04195098049;4474.686771925999;4502.617277531381;4510.120526497301;4696.92954605688;4704.788284527136;4706.1999460091865;4706.741129237925;4749.453812811502;4874.7562621868055;4913.70517768935;4965.602751779921;4969.82605608802;5020.874478138076;4696.037312350892;4705.4588722296;4735.881602959816;4741.146593613044;4810.086083644096;4954.727489988085;4959.876003099951;4960.925586116284;4966;5010.624203184849;5029.346184995927;5034.345535080416;5035.773390197523;5042.621803364689;5080.695158290514;4677.812887484462;4701.365315682476;4791.856244312677;4797.136515427256;4816.253480710496;4822.614190864792;4833.05755377712;4833.9274910875665;4872.537108974641;4875.463698993037;4731.858044258678;4746.7863946121815;4755.714657120584;4757.524247575215;4791.377120974251;4735.195016847076;4767.380240568704;4818.060478206716;4821.879453013562;4850.878728031827;4763.118823017614;4763.904302010487;4797.592204662643;4810.975945120252;4812.735299558558 09:12:37 INFO - PROCESS | 15333 | |1;ext.html;554.3347982421093;557.167035282253;560.1793372708983;570.6005795942835;572.5877368294827;27749.722502774966;37190.442143367836;38439.80780096095;38526;42082.36876446848;38927.61072389275;39202;39207.41188882169;39229.60770392295;39283.41074883879;7568.886466703004;7714.884276735854;7717.961410192969;7719.49823261489;7724.227577242259;7290.453216008794;7488.063992001;7606.467547271694;9621.711348659552;9896;9752;9795.167410770093;9798.265130115235;9816.263780216512;9819.067188617106;9960;10016.198704103726;10016.749581260454;10026.047525485068;10027.79944401108;9740.75648108796;9815;9823.410595364301;9824.852627210597;9829;36150;36509.817450912575;36513.340432233046;36539.26921461556;36618.63381366179;3065.846707664608;3083.8612262448246;3132.6710695376887;3172.984135079333;3186.7291280241207;27516.312092197655;27629.86185069082;28254.858725706446;28490.85754571214;28524;3483.3904066788464;3490.5287786148797;3494.109002204447;3558.092686364986;3638.1268495560876;247235;248676;249052;249053;249563.9999999982;51098;51618.483815162115;51655.22517162171;51951;52032;53823.46176538184;53920.460795392326;53981.730091349295;54037.72981135069;54083.188752168746;12875.806862897063;13087.214767114003;13096.476140954446;13114.147580407243;13121.278329691959;9761.853572196424;9876.851847222297;9879.753006174904;9917.107460328605;9961.252906032076;14359.497417590543;14808.703825923421;14846.628834279229;14852.2573871306;16241.918790405973;5762.337331206965;6333.809985700436;6382.936170638327;6422.45409140219;6448.419642232222;781.3241546062615;820.5609998650693;874.6938571499924;929.8326301265702;980.5146452505912;25980.610290845652;27158.321041974108;27349.589756153673;27382.726172738418;27612.309692257855;899.6221586933503;906.207068814787;908.7909780750465;916.8991410944791;941.8963913969458;14149.434022639185;14556.199409032393;14573.417063317349;14698;14868.92565537187;335985;338681;338856;339497;339848;41776.37335439971;42833;48170;48639;48886.26670599944;1115.4813011949482;1130.4743294367993;1154.342025045716;1155.7977353963022;1158.3050169898163;27064.75222973256;28263.858680707286;28752.85623571869;29209.415811683222;29328.56007159937;42019.7899010503;42428.36357454579;42543.3618495729;42569.36145957875;42658.78670606627;314847;522059;537339;537466;537642;24110.276691699277;24113.056823351522;24384.51230975406;24460.75539244656;24489;40514;40745.59254407418;40928.386074209506;41564.3765343514;41845.163096737284;34888.12779680528;35209;35280.47079293864;35410.11474713153;35433.46849797203;34788.30423391569;34815.47776783401;34978.30043399067;34998.650013500555;35585.822070890514;34418;34714;35052.29895402027;35169.82415087908;35426;29521.409571808013;31729.09625422482;31884;31891.840540797148;32146.839265803523;24333.026678932645;24370.029342811125;24442.755572444046;24837.379065522782;24902.252932412055 09:12:37 INFO - PROCESS | 15333 | |2;jquery.html;339.49772257759406;355.8043076308032;356.20743844945;360.5637179013394;363.64362924334154;12508.124431289802;15526.301316440758;15803.999999999985;15885.602859928478;16469.176541172925;16065.518034458955;16066.758998615001;16863.91568042158;16877.915610421962;17031.659366812655;4860.246661767432;4915.926261106078;5015.07221164084;5054.9241761373605;5070.467600901908;3654.671079602835;3855.2867719471847;4954.900901981958;5045.798168073273;5046.697198168104;3836.2135762168828;3874.302625527404;3883.184531248441;3885.0675837798867;4910.75446227689;5792.073268277077;5862.882742345172;5870.941290587125;5887.26409198848;5887.322957859858;5024.84925452237;5074.340335756328;5120.974395128001;5194.480551944813;5196.428392876781;19531;20014.599708005902;20182.79817201824;20246.392608221777;20292.188312467482;1945.3288615427655;2027.5539381336082;2257.119723307911;2423.648570957201;2466.8273220874366;12705.936470317682;12888;13064;13205.141665791789;13338.466461341535;1692.373821685984;1698.4395149600603;1733.6619359224956;1736.6700326937842;1763.4180720362249;65438.67280663566;65655.67172164157;66227;66451.335486645;66993.66503167454;9421.246300296098;9487.430754154773;9682.90317096834;9683.770763787617;9826.9017309826;13008.154469959612;13028.739425211443;13047.151935124186;13054.477820887058;13061.281629510468;6397.232332120176;6637.900431493532;6666.566673166229;6738.797836064828;6861.348171923659;6218.22272215973;6262.624242545462;6416.839579010562;6424.678766061678;6428.067930150102;5862.12068189775;6074.908876366858;6076.908846367308;6130.601510901777;6265.780697675559;1611.7582362645696;1655.8758093143063;1655.9172041397883;1697.7453381992552;1744.9912750436167;820.819419727659;822.4243029879109;868.4702331577732;888.7022847346083;894.4812009034745;15381.9230903847;16729.414470493473;16941.830581694026;17433.912830435765;17484.737728934077;815.4251252866715;851.438050886412;852.820907609409;890.5814267294361;905.515549181198;9221.216196623362;9776.804463910681;9858.112769850748;9873.210143188528;9970.252231082697;335974;349869;358396;358801.61797573057;360322;44462.77768611136;61333.69333153395;62753;66375;70696.29303706897;812.5043723328765;826.7189155687096;883.5449743382163;931.4271722890373;931.5528546297679;14537.636559085684;15519.146446945075;16181.919090404472;16233.51299461018;16487.587810304838;33493;33543.664563354054;34251;34461.898429141496;35458.645413545535;42627.57372426236;44332.33501497545;44428.11143777171;44901;45258.77370613126;4544.363789069599;5044.1424957756535;6105.603135796159;7139.464540159405;7189.424846012202;11593.072554195813;11617.186796924134;11753.353565553976;11805;11917.52329906794;10122.493875306352;10291.485425728833;10369;10546.156307495536;10742.409167495864;10405.47972601382;10450.634227801991;10468.63359782404;10474.581016759548;10572.101371383518;10224.539895704562;10555.63055293061;10630.468476576294;10650.360978341325;10966.958138976785;7059.71761129549;7164.319389657974;7252.202257751748;7381.335679788845;7413.9258607415395;9254.861177082485;9913.702588922344;9977.900220997697;9988.550515226978;10125.949370253102 09:12:37 INFO - PROCESS | 15333 | |3;mootools.html;1306.4382315604291;1333.7265860498599;1367.2890097149482;1591.427086248951;1601.1593913195563;6365.077063825748;6680.933190668092;6684.364985326386;6697.2967838376935;6702.430293425059;5724.856878578038;5984.341722410542;6313.62118272904;6493.577917435376;6514;1982.851286153537;2015.8488113391481;2022.29219773079;2027.5539381336082;2039.0212697905015;1937.7577802774654;2017.3645301729982;2022.0294258755805;2032.2886989553685;2032.3090149349218;1727.4299481171183;1768.991155044223;1885.9717104243448;1927.7493925789627;2000.9099590518388;1945.173301346929;1949.2885096939585;1950.8634395592314;1952.1117891359397;1958.6768183249746;1816.1827177770056;1824.917878695462;1849.9630007399912;1992.2927360786857;1996.3511858645998;6684.732610695566;6729.596224226513;6851.07510486088;6892.724291028353;6926.619035953021;4060.167665628539;4193.811278492444;4201.789910504463;4203.516595591515;4212.578742125794;2594.8832302546243;2789.790765692561;2833.4474777418413;2856.3144845237202;2857.3713782967716;845.5856630251194;917.2661870503637;919.3748251189189;938.2962777916563;944.7449188719007;8581.184787445183;8792.428492148054;8812.647494100229;8935.061818509093;9004.784354112177;3577.481265216529;3615.665890123291;3624.7643903146213;3698.500702405141;3710.888673339804;7056.223815380304;7059.682314295869;7061.646917654097;7067.5052746307265;7075.186353569303;4042.3532234842282;4043.838246470108;4044.170944956277;4047.5952404759287;4062.979685101615;3808;3808.5239345081864;3808.847646094125;3815.122521819997;3817.2938006468335;2949.3953739483354;3046.116626178428;3070.2938324185116;3087.228192951762;3089.567460555524;916.083916083916;921.755734730297;926.5228407370209;926.8517037274004;949.534727983297;719.7408932784193;725.9147574376341;740.1968863782748;746.1307576673223;751.2637615137087;4404.273294906305;4424.6902716810155;4478.350639157304;4604.470485894098;4609.216433206363;744.4528271720282;751.2675141736872;753.2241790955325;766.2605585609801;766.6626684258908;2926.443975644621;2954.5715871198554;2991.730744232986;3043.832589207615;3108.0675797260733;7622;7910.367170626336;7920.247576480225;8170.387220958333;8195;8136.55248961301;8137.796555086052;8138.837223255502;8145.959270203611;8148.796280092926;6316.084167795644;6433.324500927335;6435.710393032325;6466.773662921869;6475.287718351072;4351.543087975843;4358.4769827620885;4362.629176520031;4379.098269109521;4509.729416235036;7372.115346158495;7589.886151707839;7706.807329816799;7759.7672069838;7766.534007959541;7678.731244406419;7763.184865589032;7791.610419479117;7800.687972481264;7812.804679883048;5874.236349274567;6051.75792968294;6053.818385448443;6054.061620448838;6055.939440605537;6110.450059494667;6130.601510901777;6164.506839452743;6176.969115154575;6178.289496707936;5788.21859049023;5794.0439827428;5840.591158618856;5860.853478663067;5909.379515151019;5707.286589176353;5809.186713859978;5879.617824841372;5951.315598706031;5981.730822112929;5483.588730845123;5536.889262214814;5565.9721701392855;5571.13647384656;5571.13647384656;4057.959420405758;4064.1465292287767;4065.329220678673;4134.049168691157;4229.788510574397;3855.132595166065;3863.24666690004;3895.902602434962;3920.4707364505425;3921.5490218625223 09:12:37 INFO - PROCESS | 15333 | |4;prototype.html;255.12237901618442;255.20758046266343;265.84182411465184;274.71155286948704;280.60154580495686;4692.577668009879;4795.616350691941;4874.756262186894;4896.926546101811;4907.423602608632;4739.5023522530155;4746.3117847912035;4773.785179666915;4799.68802027868;4828.275758636207;3625.329314076891;3776.1503661676043;3812.618738126179;3816.313063648542;3821.7515861468914;3565.450702747535;3670.724695647837;3678.393065144248;3745.6441638044344;3787.3561494545856;3749.531308586427;3756.6663834338824;3762.7177961652988;3769.623037696222;3771.2080463102643;3741.120836603396;3742.532183477079;3764.4353346997896;3768.340540405418;3798.974276945237;3156.9684303157132;3245.7666086887066;3259.5110733389943;3316.2041110133637;3332.766706330558;4699.355225671022;4717.2452407614965;4732.905341893177;4743.980044290494;4768.976155119202;4285.764282964436;4306.397104405386;4312.353147027971;4333;4336.761478118702;4817.807287708488;5022.42242142151;5039.571636410909;5043.36957880265;5051.090803655341;3606.855725770966;3617.8371973261005;3624.586411299595;3627.528421305213;3631.0740761106013;5305.65513241638;5322.175062865262;5335.7865685372535;5346.599005074635;5352.304200453916;3713.814309284579;3741.120836603396;3744.7940363279736;3747.2880152770886;3750.681192098702;3570.250247448013;3724.1434470072036;3760.3983362661843;3763.717721170923;3766.981165094157;4034.636882680573;4098.692598055158;4128;4239.618434340862;4294.3558466230315;4991.825286115041;5014.222795466709;5020.748962551857;5030.7233102179;5040.873978150576;1231.4396949388006;1242.6641360537458;1251.7121062155754;1257.9874201258053;1273.6943133647858;826.8098337382436;867.0635713429481;869.452245085592;879.8372301124313;884.0584777212248;4288.399624052635;4308.728924967142;4353.673474489426;4354.891127721832;4359.934600980988;5008;5020.648554601216;5050.747462626854;5064.354084922415;5114.539691427789;4325.6106950374615;4347.2176407672705;4348.173846969065;4357.694961352739;4363.759993200404;2546.675728621107;2664.786817054631;2693;2707.6073969274344;2709.618094771641;4789.257665061921;4811.78346974387;4812.951870481251;4813.253945638432;4834.20235661119;4910.975445122752;5134.409542902539;5195.298634684269;5199.766010529535;5215.739213039333;4796.496367881392;4802.399700037496;4807.831725889507;4835.854924352275;4848.612111031109;5093.18509038552;5093.567046800915;5102.285680004877;5114.923276150935;5120.769565369493;4891.51084891508;4999.500049994971;5005.874853128701;5022.347094877642;5030.622703297194;4971;4984.4517103117905;4991.2565575818135;4991.650584459053;4992.1529034257555;3617.6924961377526;3621.0766254604905;3630.528031355907;3635.5092062571216;3637.636236376341;4983.775730092227;5043.773030213576;5312.309399778004;5322.228276899906;5325.573954083741;5075.695458272516;5102.387713474407;5102.4897510248675;5103.591712663052;5107.10625640504;5122.667026643257;5125;5138.820141295037;5145.919356934935;5147.819826306061;4868.513148685245;5007.799688012438;5039.672421292605;5055.634978555843;5065.39215294167;5139.353233085039;5162.019216349032;5166.560842328444;5170.484070831871;5171.896562068662;4952.656956554383;5023.4725353838785;5028;5028.823991160292;5047.242913562848 09:12:37 INFO - PROCESS | 15333 | |5;yui.html;601.8435206846219;670.2593634034395;678.8167194857392;695.3950063444802;698.4552049401468;11411.25826821257;11583.768324633502;11619.12856535761;11642.06863450924;11677.124215683814;13022.479100835979;13193.34033298336;13207.273599952;13237.801432978513;13250.271235082068;593.264352203267;609.1928195141434;721.293132729925;740.7407407407418;747.977560673178;742.610129681916;751.0649241694099;752.2101793117232;752.5559919647407;753.446217030485;791.3589992106412;793.1434051224663;796.8286818334057;797.3262593108843;798.2217338095339;625.5089754542662;642.502060902804;766.8044648614623;782.2803021220491;797.0117054851971;584.1267305378444;584.3426145586216;584.8742520358101;584.9327327357323;585.0697391148052;11777.58778442759;11778.057755379548;11778.057755379548;11807.996320312785;11812.940935295355;12075.637730868088;12200.511979520808;12572.30852303132;12603.810942835864;12661.746765064647;9607.663731769355;11266.267692599955;11383.260088094248;11758.17692761507;11759;3166.335069635379;3184.1243657994237;3257.3973814844094;3388.5594872666643;4007.9599204007877;64998.350016500175;65008.674956625386;66736.66631666859;67605.66197169032;67761.66119169422;9132.908670913339;9596.088371604686;9632.422054676741;9705.805883882424;9874.308798384043;18143.909280453514;18166.727499087523;18184;18282;18372.448826535227;6242;6287.182666253358;6422.935770642233;6433.388828061326;6493;3458.706009989179;3506.263684626206;3525.823708814549;3557.1107223194203;3583;2691.4751623433635;2760.144355249839;2787.9024234151707;2793.050362876632;2795.6086147939304;449.42249209765293;450.981960721574;454.1779379323435;455.37840847243274;457.61560289356436;463.9605633521121;533.4425525326044;533.8104972734624;537.2914133056917;565.9236003139606;7680.692772289158;8010.198980101944;8091.757247282591;8263.917360826435;8329.708460203863;552.4475524475524;561.166667498764;566.9971650141723;571.0919637775957;576.1214148423604;3756.9812150939615;3996.2407142642805;4060.4112403701297;4527.796249168795;4554.3851580036935;64207.35792642107;64922;65921.82680723668;67321.32678673249;69912.30087699057;54630.45369546333;54783.726081370136;55538.16692749612;56392.71803641038;57566.560835979435;53076.20385694218;53379.73310133425;54064.729676351366;55004;55191.448085519434;8625.568721564023;9106.453612783254;9190.221428892022;9201.953990230273;9262.65691474719;35901.461478078374;37424;37497.062573435884;37721.43417848789;38558.6144138555;44642.776786115865;47898;49407.25889111594;49780;51419.74290128525;10474.371537707762;10638.41488718128;10718.14254859625;10807.891921081004;10848.077913377452;12438.751224975269;12843;12846.743065138458;12950.93524532409;13109.475620975054;9307;11347.773044539228;11612;12065.698357540781;12714.235312240948;11842.644720658394;12019.819702704292;12184.329861857683;12185.268883866996;12852.485900563872;11163.944180279046;11612.575812606916;11711.297322160697;12106.576269830513;12609.180403273758;9626.422414655142;9853.261005424765;9905.15806156456;9911.45486998222;10279.229057820543;9987.800243995225;10064.39613623185;10074.949625251827;10308.948455257676;10335.121514671337 09:12:37 INFO - PROCESS | 15333 | __end_tp_report 09:12:37 INFO - PROCESS | 15333 | __start_cc_report 09:12:37 INFO - PROCESS | 15333 | _x_x_mozilla_cycle_collect,1413 09:12:37 INFO - PROCESS | 15333 | __end_cc_report 09:12:37 INFO - PROCESS | 15333 | __startTimestamp1480353157814__endTimestamp 09:12:37 INFO - PROCESS | 15333 | 09:12:37 INFO - PROCESS | 15333 | ------- Summary: start ------- 09:12:37 INFO - PROCESS | 15333 | Number of tests: 6 09:12:37 INFO - PROCESS | 15333 | 09:12:37 INFO - PROCESS | 15333 | [#0] dojo.html Cycles:165 Average:4582.26 Median:4706.74 stddev:465.11 (9.9%) stddev-sans-first:439.04 09:12:37 INFO - PROCESS | 15333 | Values: 2573.8 2607.2 2631.9 2636.4 2638.7 4520.1 4581.5 4627.8 4679.9 4691.0 4599.6 4617.6 4619.0 4623.5 4629.1 4224.1 4247.7 4268.8 4281.3 4290.5 4314.9 4341.5 4347.8 4356.2 4357.3 4203.2 4218.9 4242.5 4247.2 4350.5 4288.2 4292.1 4295.1 4304.9 4317.7 4146.7 4154.5 4169.6 4228.0 4261.6 4580.9 4603.1 4605.6 4616.8 4627.9 4921.8 4932.5 4953.1 4964.3 4991.6 4848.9 4862.2 4969.6 4975.5 5012.7 4579.6 4580.6 4598.5 4599.5 4600.0 5012.9 5024.1 5025.5 5028.9 5033.5 4849.8 4915.0 4920.8 4927.5 4927.7 4869.2 4945.2 4947.9 4952.0 4996.9 4823.1 4864.8 4875.4 4905.9 4949.9 4741.4 4786.3 4787.1 4842.6 4886.0 4245.9 4247.3 4248.1 4269.0 4292.8 3766.1 3768.9 3771.2 3773.3 3776.5 4247.4 4272.1 4280.7 4284.1 4290.9 4932.9 4937.3 4948.6 4951.5 4957.6 4249.8 4262.0 4265.7 4266.5 4268.0 4443.9 4456.0 4474.7 4502.6 4510.1 4696.9 4704.8 4706.2 4706.7 4749.5 4874.8 4913.7 4965.6 4969.8 5020.9 4696.0 4705.5 4735.9 4741.1 4810.1 4954.7 4959.9 4960.9 4966.0 5010.6 5029.3 5034.3 5035.8 5042.6 5080.7 4677.8 4701.4 4791.9 4797.1 4816.3 4822.6 4833.1 4833.9 4872.5 4875.5 4731.9 4746.8 4755.7 4757.5 4791.4 4735.2 4767.4 4818.1 4821.9 4850.9 4763.1 4763.9 4797.6 4811.0 4812.7 09:12:37 INFO - PROCESS | 15333 | 09:12:37 INFO - PROCESS | 15333 | [#1] ext.html Cycles:180 Average:50243.32 Median:19894.06 stddev:100019.41 (502.8%) stddev-sans-first:100230.41 09:12:37 INFO - PROCESS | 15333 | Values: 554.3 557.2 560.2 570.6 572.6 27749.7 37190.4 38439.8 38526.0 42082.4 38927.6 39202.0 39207.4 39229.6 39283.4 7568.9 7714.9 7718.0 7719.5 7724.2 7290.5 7488.1 7606.5 9621.7 9896.0 9752.0 9795.2 9798.3 9816.3 9819.1 9960.0 10016.2 10016.7 10026.0 10027.8 9740.8 9815.0 9823.4 9824.9 9829.0 36150.0 36509.8 36513.3 36539.3 36618.6 3065.8 3083.9 3132.7 3173.0 3186.7 27516.3 27629.9 28254.9 28490.9 28524.0 3483.4 3490.5 3494.1 3558.1 3638.1 247235.0 248676.0 249052.0 249053.0 249564.0 51098.0 51618.5 51655.2 51951.0 52032.0 53823.5 53920.5 53981.7 54037.7 54083.2 12875.8 13087.2 13096.5 13114.1 13121.3 9761.9 9876.9 9879.8 9917.1 9961.3 14359.5 14808.7 14846.6 14852.3 16241.9 5762.3 6333.8 6382.9 6422.5 6448.4 781.3 820.6 874.7 929.8 980.5 25980.6 27158.3 27349.6 27382.7 27612.3 899.6 906.2 908.8 916.9 941.9 14149.4 14556.2 14573.4 14698.0 14868.9 335985.0 338681.0 338856.0 339497.0 339848.0 41776.4 42833.0 48170.0 48639.0 48886.3 1115.5 1130.5 1154.3 1155.8 1158.3 27064.8 28263.9 28752.9 29209.4 29328.6 42019.8 42428.4 42543.4 42569.4 42658.8 314847.0 522059.0 537339.0 537466.0 537642.0 24110.3 24113.1 24384.5 24460.8 24489.0 40514.0 40745.6 40928.4 41564.4 41845.2 34888.1 35209.0 35280.5 35410.1 35433.5 34788.3 34815.5 34978.3 34998.7 35585.8 34418.0 34714.0 35052.3 35169.8 35426.0 29521.4 31729.1 31884.0 31891.8 32146.8 24333.0 24370.0 24442.8 24837.4 24902.3 09:12:37 INFO - PROCESS | 15333 | 09:12:37 INFO - PROCESS | 15333 | [#2] jquery.html Cycles:180 Average:22415.78 Median:3884.13 stddev:58037.51 (1494.2%) stddev-sans-first:58176.65 09:12:37 INFO - PROCESS | 15333 | Values: 339.5 355.8 356.2 360.6 363.6 12508.1 15526.3 15804.0 15885.6 16469.2 16065.5 16066.8 16863.9 16877.9 17031.7 4860.2 4915.9 5015.1 5054.9 5070.5 3654.7 3855.3 4954.9 5045.8 5046.7 3836.2 3874.3 3883.2 3885.1 4910.8 5792.1 5862.9 5870.9 5887.3 5887.3 5024.8 5074.3 5121.0 5194.5 5196.4 19531.0 20014.6 20182.8 20246.4 20292.2 1945.3 2027.6 2257.1 2423.6 2466.8 12705.9 12888.0 13064.0 13205.1 13338.5 1692.4 1698.4 1733.7 1736.7 1763.4 65438.7 65655.7 66227.0 66451.3 66993.7 9421.2 9487.4 9682.9 9683.8 9826.9 13008.2 13028.7 13047.2 13054.5 13061.3 6397.2 6637.9 6666.6 6738.8 6861.3 6218.2 6262.6 6416.8 6424.7 6428.1 5862.1 6074.9 6076.9 6130.6 6265.8 1611.8 1655.9 1655.9 1697.7 1745.0 820.8 822.4 868.5 888.7 894.5 15381.9 16729.4 16941.8 17433.9 17484.7 815.4 851.4 852.8 890.6 905.5 9221.2 9776.8 9858.1 9873.2 9970.3 335974.0 349869.0 358396.0 358801.6 360322.0 44462.8 61333.7 62753.0 66375.0 70696.3 812.5 826.7 883.5 931.4 931.6 14537.6 15519.1 16181.9 16233.5 16487.6 33493.0 33543.7 34251.0 34461.9 35458.6 42627.6 44332.3 44428.1 44901.0 45258.8 4544.4 5044.1 6105.6 7139.5 7189.4 11593.1 11617.2 11753.4 11805.0 11917.5 10122.5 10291.5 10369.0 10546.2 10742.4 10405.5 10450.6 10468.6 10474.6 10572.1 10224.5 10555.6 10630.5 10650.4 10967.0 7059.7 7164.3 7252.2 7381.3 7413.9 9254.9 9913.7 9977.9 9988.6 10125.9 09:12:37 INFO - PROCESS | 15333 | 09:12:37 INFO - PROCESS | 15333 | [#3] mootools.html Cycles:180 Average:4411.79 Median:5716.07 stddev:2378.31 (41.6%) stddev-sans-first:2373.54 09:12:37 INFO - PROCESS | 15333 | Values: 1306.4 1333.7 1367.3 1591.4 1601.2 6365.1 6680.9 6684.4 6697.3 6702.4 5724.9 5984.3 6313.6 6493.6 6514.0 1982.9 2015.8 2022.3 2027.6 2039.0 1937.8 2017.4 2022.0 2032.3 2032.3 1727.4 1769.0 1886.0 1927.7 2000.9 1945.2 1949.3 1950.9 1952.1 1958.7 1816.2 1824.9 1850.0 1992.3 1996.4 6684.7 6729.6 6851.1 6892.7 6926.6 4060.2 4193.8 4201.8 4203.5 4212.6 2594.9 2789.8 2833.4 2856.3 2857.4 845.6 917.3 919.4 938.3 944.7 8581.2 8792.4 8812.6 8935.1 9004.8 3577.5 3615.7 3624.8 3698.5 3710.9 7056.2 7059.7 7061.6 7067.5 7075.2 4042.4 4043.8 4044.2 4047.6 4063.0 3808.0 3808.5 3808.8 3815.1 3817.3 2949.4 3046.1 3070.3 3087.2 3089.6 916.1 921.8 926.5 926.9 949.5 719.7 725.9 740.2 746.1 751.3 4404.3 4424.7 4478.4 4604.5 4609.2 744.5 751.3 753.2 766.3 766.7 2926.4 2954.6 2991.7 3043.8 3108.1 7622.0 7910.4 7920.2 8170.4 8195.0 8136.6 8137.8 8138.8 8146.0 8148.8 6316.1 6433.3 6435.7 6466.8 6475.3 4351.5 4358.5 4362.6 4379.1 4509.7 7372.1 7589.9 7706.8 7759.8 7766.5 7678.7 7763.2 7791.6 7800.7 7812.8 5874.2 6051.8 6053.8 6054.1 6055.9 6110.5 6130.6 6164.5 6177.0 6178.3 5788.2 5794.0 5840.6 5860.9 5909.4 5707.3 5809.2 5879.6 5951.3 5981.7 5483.6 5536.9 5566.0 5571.1 5571.1 4058.0 4064.1 4065.3 4134.0 4229.8 3855.1 3863.2 3895.9 3920.5 3921.5 09:12:37 INFO - PROCESS | 15333 | 09:12:37 INFO - PROCESS | 15333 | [#4] prototype.html Cycles:180 Average:4176.65 Median:4796.06 stddev:1222.81 (25.5%) stddev-sans-first:1190.29 09:12:37 INFO - PROCESS | 15333 | Values: 255.1 255.2 265.8 274.7 280.6 4692.6 4795.6 4874.8 4896.9 4907.4 4739.5 4746.3 4773.8 4799.7 4828.3 3625.3 3776.2 3812.6 3816.3 3821.8 3565.5 3670.7 3678.4 3745.6 3787.4 3749.5 3756.7 3762.7 3769.6 3771.2 3741.1 3742.5 3764.4 3768.3 3799.0 3157.0 3245.8 3259.5 3316.2 3332.8 4699.4 4717.2 4732.9 4744.0 4769.0 4285.8 4306.4 4312.4 4333.0 4336.8 4817.8 5022.4 5039.6 5043.4 5051.1 3606.9 3617.8 3624.6 3627.5 3631.1 5305.7 5322.2 5335.8 5346.6 5352.3 3713.8 3741.1 3744.8 3747.3 3750.7 3570.3 3724.1 3760.4 3763.7 3767.0 4034.6 4098.7 4128.0 4239.6 4294.4 4991.8 5014.2 5020.7 5030.7 5040.9 1231.4 1242.7 1251.7 1258.0 1273.7 826.8 867.1 869.5 879.8 884.1 4288.4 4308.7 4353.7 4354.9 4359.9 5008.0 5020.6 5050.7 5064.4 5114.5 4325.6 4347.2 4348.2 4357.7 4363.8 2546.7 2664.8 2693.0 2707.6 2709.6 4789.3 4811.8 4813.0 4813.3 4834.2 4911.0 5134.4 5195.3 5199.8 5215.7 4796.5 4802.4 4807.8 4835.9 4848.6 5093.2 5093.6 5102.3 5114.9 5120.8 4891.5 4999.5 5005.9 5022.3 5030.6 4971.0 4984.5 4991.3 4991.7 4992.2 3617.7 3621.1 3630.5 3635.5 3637.6 4983.8 5043.8 5312.3 5322.2 5325.6 5075.7 5102.4 5102.5 5103.6 5107.1 5122.7 5125.0 5138.8 5145.9 5147.8 4868.5 5007.8 5039.7 5055.6 5065.4 5139.4 5162.0 5166.6 5170.5 5171.9 4952.7 5023.5 5028.0 5028.8 5047.2 09:12:37 INFO - PROCESS | 15333 | 09:12:37 INFO - PROCESS | 15333 | [#5] yui.html Cycles:180 Average:14973.13 Median:48652.63 stddev:18963.02 (39.0%) stddev-sans-first:18985.51 09:12:37 INFO - PROCESS | 15333 | Values: 601.8 670.3 678.8 695.4 698.5 11411.3 11583.8 11619.1 11642.1 11677.1 13022.5 13193.3 13207.3 13237.8 13250.3 593.3 609.2 721.3 740.7 748.0 742.6 751.1 752.2 752.6 753.4 791.4 793.1 796.8 797.3 798.2 625.5 642.5 766.8 782.3 797.0 584.1 584.3 584.9 584.9 585.1 11777.6 11778.1 11778.1 11808.0 11812.9 12075.6 12200.5 12572.3 12603.8 12661.7 9607.7 11266.3 11383.3 11758.2 11759.0 3166.3 3184.1 3257.4 3388.6 4008.0 64998.4 65008.7 66736.7 67605.7 67761.7 9132.9 9596.1 9632.4 9705.8 9874.3 18143.9 18166.7 18184.0 18282.0 18372.4 6242.0 6287.2 6422.9 6433.4 6493.0 3458.7 3506.3 3525.8 3557.1 3583.0 2691.5 2760.1 2787.9 2793.1 2795.6 449.4 451.0 454.2 455.4 457.6 464.0 533.4 533.8 537.3 565.9 7680.7 8010.2 8091.8 8263.9 8329.7 552.4 561.2 567.0 571.1 576.1 3757.0 3996.2 4060.4 4527.8 4554.4 64207.4 64922.0 65921.8 67321.3 69912.3 54630.5 54783.7 55538.2 56392.7 57566.6 53076.2 53379.7 54064.7 55004.0 55191.4 8625.6 9106.5 9190.2 9202.0 9262.7 35901.5 37424.0 37497.1 37721.4 38558.6 44642.8 47898.0 49407.3 49780.0 51419.7 10474.4 10638.4 10718.1 10807.9 10848.1 12438.8 12843.0 12846.7 12950.9 13109.5 9307.0 11347.8 11612.0 12065.7 12714.2 11842.6 12019.8 12184.3 12185.3 12852.5 11163.9 11612.6 11711.3 12106.6 12609.2 9626.4 9853.3 9905.2 9911.5 10279.2 9987.8 10064.4 10074.9 10308.9 10335.1 09:12:37 INFO - PROCESS | 15333 | -------- Summary: end -------- 09:12:37 INFO - PROCESS | 15333 | 09:12:38 INFO - TEST-INFO | 15333: exit 0 09:12:38 INFO - TEST-OK | dromaeo_css | took 1123928ms 09:12:38 INFO - TEST-START | kraken 09:12:38 INFO - operating with platform_type : linux_ 09:12:38 INFO - Initialising browser for kraken test... 09:12:38 INFO - TEST-INFO | started process 15632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmbCVBC/profile http://localhost:37795/getInfo.html) 09:12:43 INFO - PROCESS | 15632 | __metrics Screen width/height:1600/1200 09:12:43 INFO - PROCESS | 15632 | colorDepth:24 09:12:43 INFO - PROCESS | 15632 | Browser inner width/height: 1024/697 09:12:43 INFO - PROCESS | 15632 | __metrics 09:12:43 INFO - PROCESS | 15632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:12:43 INFO - PROCESS | 15632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:12:44 INFO - PROCESS | 15632 | console.error: PushService: 09:12:44 INFO - PROCESS | 15632 | stateChangeProcessEnqueue: Error transitioning state 09:12:44 INFO - PROCESS | 15632 | UnknownError 09:12:45 INFO - TEST-INFO | 15632: exit 0 09:12:45 INFO - Browser initialized. 09:12:45 INFO - Running cycle 1/1 for kraken test... 09:12:45 INFO - TEST-INFO | started process 15716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmbCVBC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:57 INFO - PROCESS | 15716 | RSS: Main: 175140864 09:12:57 INFO - PROCESS | 15716 | 09:13:00 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37795/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:01 INFO - PROCESS | 15716 | RSS: Main: 236150784 09:13:01 INFO - PROCESS | 15716 | 09:13:04 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37795/tests/kraken/driver.html?testName=audio-dft) 09:13:05 INFO - PROCESS | 15716 | RSS: Main: 218882048 09:13:05 INFO - PROCESS | 15716 | 09:13:08 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37795/tests/kraken/driver.html?testName=audio-fft) 09:13:08 INFO - PROCESS | 15716 | RSS: Main: 301068288 09:13:08 INFO - PROCESS | 15716 | 09:13:10 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37795/tests/kraken/driver.html?testName=audio-oscillator) 09:13:11 INFO - PROCESS | 15716 | RSS: Main: 210530304 09:13:11 INFO - PROCESS | 15716 | 09:13:13 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:14 INFO - PROCESS | 15716 | RSS: Main: 214798336 09:13:14 INFO - PROCESS | 15716 | 09:13:17 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37795/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:18 INFO - PROCESS | 15716 | RSS: Main: 254218240 09:13:18 INFO - PROCESS | 15716 | 09:13:21 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37795/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:22 INFO - PROCESS | 15716 | RSS: Main: 248299520 09:13:22 INFO - PROCESS | 15716 | 09:13:25 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37795/tests/kraken/driver.html?testName=json-parse-financial) 09:13:25 INFO - PROCESS | 15716 | RSS: Main: 250146816 09:13:25 INFO - PROCESS | 15716 | 09:13:27 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:28 INFO - PROCESS | 15716 | RSS: Main: 213479424 09:13:28 INFO - PROCESS | 15716 | 09:13:30 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37795/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:30 INFO - PROCESS | 15716 | RSS: Main: 221609984 09:13:30 INFO - PROCESS | 15716 | 09:13:32 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:33 INFO - PROCESS | 15716 | RSS: Main: 228724736 09:13:33 INFO - PROCESS | 15716 | 09:13:36 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:37 INFO - PROCESS | 15716 | RSS: Main: 238186496 09:13:37 INFO - PROCESS | 15716 | 09:13:40 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:40 INFO - PROCESS | 15716 | RSS: Main: 234119168 09:13:40 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:37795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37795/tests/kraken/driver.html?testName=ai-astar) 09:13:42 INFO - PROCESS | 15716 | RSS: Main: 285913088 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | __start_tp_report 09:13:42 INFO - PROCESS | 15716 | _x_x_mozilla_page_load 09:13:42 INFO - PROCESS | 15716 | _x_x_mozilla_page_load_details 09:13:42 INFO - PROCESS | 15716 | |i|pagename|runs| 09:13:42 INFO - PROCESS | 15716 | |0;ai-astar;113;117;116;116;116;119;117;118;118;115 09:13:42 INFO - PROCESS | 15716 | |1;audio-beat-detection;153;129;140;167;140;132;136;130;157;139 09:13:42 INFO - PROCESS | 15716 | |2;audio-dft;161;162;164;162;164;161;161;162;162;163 09:13:42 INFO - PROCESS | 15716 | |3;audio-fft;77;77;76;111;78;76;76;86;92;77 09:13:42 INFO - PROCESS | 15716 | |4;audio-oscillator;84;83;103;84;84;84;104;84;84;100 09:13:42 INFO - PROCESS | 15716 | |5;imaging-gaussian-blur;118;117;118;118;118;118;117;118;117;118 09:13:42 INFO - PROCESS | 15716 | |6;imaging-darkroom;145;145;147;148;147;147;148;147;148;147 09:13:42 INFO - PROCESS | 15716 | |7;imaging-desaturate;95;96;95;95;96;95;96;96;96;96 09:13:42 INFO - PROCESS | 15716 | |8;json-parse-financial;67;65;64;64;65;66;65;66;66;66 09:13:42 INFO - PROCESS | 15716 | |9;json-stringify-tinderbox;66;66;66;65;66;66;68;66;66;66 09:13:42 INFO - PROCESS | 15716 | |10;stanford-crypto-aes;85;84;84;86;85;85;85;84;86;85 09:13:42 INFO - PROCESS | 15716 | |11;stanford-crypto-ccm;145;154;144;152;145;142;143;140;181;143 09:13:42 INFO - PROCESS | 15716 | |12;stanford-crypto-pbkdf2;181;181;181;181;180;183;187;183;180;187 09:13:42 INFO - PROCESS | 15716 | |13;stanford-crypto-sha256-iterative;75;75;72;71;71;72;71;72;70;72 09:13:42 INFO - PROCESS | 15716 | __end_tp_report 09:13:42 INFO - PROCESS | 15716 | __start_cc_report 09:13:42 INFO - PROCESS | 15716 | _x_x_mozilla_cycle_collect,1971 09:13:42 INFO - PROCESS | 15716 | __end_cc_report 09:13:42 INFO - PROCESS | 15716 | __startTimestamp1480353222820__endTimestamp 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | ------- Summary: start ------- 09:13:42 INFO - PROCESS | 15716 | Number of tests: 14 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.00 stddev:1.72 (1.5%) stddev-sans-first:1.27 09:13:42 INFO - PROCESS | 15716 | Values: 113.0 117.0 116.0 116.0 116.0 119.0 117.0 118.0 118.0 115.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:140.00 stddev:12.63 (9.0%) stddev-sans-first:12.79 09:13:42 INFO - PROCESS | 15716 | Values: 153.0 129.0 140.0 167.0 140.0 132.0 136.0 130.0 157.0 139.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 09:13:42 INFO - PROCESS | 15716 | Values: 161.0 162.0 164.0 162.0 164.0 161.0 161.0 162.0 162.0 163.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:11.32 (14.7%) stddev-sans-first:11.82 09:13:42 INFO - PROCESS | 15716 | Values: 77.0 77.0 76.0 111.0 78.0 76.0 76.0 86.0 92.0 77.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:84.00 stddev:8.98 (10.7%) stddev-sans-first:9.31 09:13:42 INFO - PROCESS | 15716 | Values: 84.0 83.0 103.0 84.0 84.0 84.0 104.0 84.0 84.0 100.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:13:42 INFO - PROCESS | 15716 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:0.93 09:13:42 INFO - PROCESS | 15716 | Values: 145.0 145.0 147.0 148.0 147.0 147.0 148.0 147.0 148.0 147.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:13:42 INFO - PROCESS | 15716 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:0.83 09:13:42 INFO - PROCESS | 15716 | Values: 67.0 65.0 64.0 64.0 65.0 66.0 65.0 66.0 66.0 66.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 09:13:42 INFO - PROCESS | 15716 | Values: 66.0 66.0 66.0 65.0 66.0 66.0 68.0 66.0 66.0 66.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 09:13:42 INFO - PROCESS | 15716 | Values: 85.0 84.0 84.0 86.0 85.0 85.0 85.0 84.0 86.0 85.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:145.00 stddev:12.10 (8.3%) stddev-sans-first:12.75 09:13:42 INFO - PROCESS | 15716 | Values: 145.0 154.0 144.0 152.0 145.0 142.0 143.0 140.0 181.0 143.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.40 Median:182.00 stddev:2.63 (1.4%) stddev-sans-first:2.74 09:13:42 INFO - PROCESS | 15716 | Values: 181.0 181.0 181.0 181.0 180.0 183.0 187.0 183.0 180.0 187.0 09:13:42 INFO - PROCESS | 15716 | 09:13:42 INFO - PROCESS | 15716 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:1.66 (2.3%) stddev-sans-first:1.39 09:13:42 INFO - PROCESS | 15716 | Values: 75.0 75.0 72.0 71.0 71.0 72.0 71.0 72.0 70.0 72.0 09:13:42 INFO - PROCESS | 15716 | -------- Summary: end -------- 09:13:42 INFO - PROCESS | 15716 | 09:13:44 INFO - TEST-INFO | 15716: exit 0 09:13:44 INFO - TEST-OK | kraken | took 65278ms 09:13:44 INFO - SUITE-END | took 1189s 09:13:44 INFO - Completed test suite (00:19:49) 09:13:44 INFO - javascript benchmark 09:13:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2573.806964477664, 2607.178738697309, 2631.868406579671, 2636.433166869123, 2638.7229340919203, 4520.050789334244, 4581.518940511249, 4627.8380256691025, 4679.906401871961, 4690.976545117274, 4599.586037256646, 4617.630589552836, 4619.0, 4623.514530974249, 4629.0510445358705, 4224.091820258652, 4247.681423893205, 4268.765217913029, 4281.272183728758, 4290.4851417829905, 4314.892127696817, 4341.479022517302, 4347.847825326115, 4356.150550642626, 4357.346398040288, 4203.159368126372, 4218.936715949263, 4242.53332133465, 4247.171801498709, 4350.456192975878, 4288.206681763883, 4292.098659281554, 4295.119500502389, 4304.870853874358, 4317.740935543861, 4146.709730318879, 4154.5222299435345, 4169.624733773944, 4227.957720422818, 4261.552536983634, 4580.885477863047, 4603.056373443436, 4605.631549476034, 4616.792244349012, 4627.930581041287, 4921.7785199666105, 4932.531409516126, 4953.133201689726, 4964.280179373971, 4991.600671946236, 4848.927266091011, 4862.17343051682, 4969.627277954131, 4975.4527002029745, 5012.72430016349, 4579.610733087725, 4580.610648094949, 4598.471175814757, 4599.471060827981, 4599.954000460019, 5012.874678133003, 5024.145895197752, 5025.497450254945, 5028.874278143076, 5033.47148549397, 4849.830255941096, 4915.0, 4920.778564964585, 4927.482614325444, 4927.655064145547, 4869.172240719086, 4945.159322915113, 4947.925781113287, 4951.9752401237765, 4996.925046124311, 4823.131836269506, 4864.802921671943, 4875.43932447773, 4905.9264111038365, 4949.876253093701, 4741.43102827656, 4786.305985632064, 4787.066522028241, 4842.58837998774, 4886.047220791983, 4245.87262382129, 4247.256730072225, 4248.1078973415315, 4268.9786551067045, 4292.763897985578, 3766.133789228493, 3768.9434658480145, 3771.2268984858038, 3773.339665558516, 3776.50905382304, 4247.405363249148, 4272.124214536075, 4280.700350975402, 4284.100338928797, 4290.935635965463, 4932.90134197314, 4937.333459982857, 4948.554630083309, 4951.480094590088, 4957.553820156203, 4249.80875860587, 4262.041040765803, 4265.680073994463, 4266.488021437447, 4268.039691069484, 4443.866683999485, 4456.04195098049, 4474.686771925999, 4502.617277531381, 4510.120526497301, 4696.92954605688, 4704.788284527136, 4706.1999460091865, 4706.741129237925, 4749.453812811502, 4874.7562621868055, 4913.70517768935, 4965.602751779921, 4969.82605608802, 5020.874478138076, 4696.037312350892, 4705.4588722296, 4735.881602959816, 4741.146593613044, 4810.086083644096, 4954.727489988085, 4959.876003099951, 4960.925586116284, 4966.0, 5010.624203184849, 5029.346184995927, 5034.345535080416, 5035.773390197523, 5042.621803364689, 5080.695158290514, 4677.812887484462, 4701.365315682476, 4791.856244312677, 4797.136515427256, 4816.253480710496, 4822.614190864792, 4833.05755377712, 4833.9274910875665, 4872.537108974641, 4875.463698993037, 4731.858044258678, 4746.7863946121815, 4755.714657120584, 4757.524247575215, 4791.377120974251, 4735.195016847076, 4767.380240568704, 4818.060478206716, 4821.879453013562, 4850.878728031827, 4763.118823017614, 4763.904302010487, 4797.592204662643, 4810.975945120252, 4812.735299558558], "value": 4553.409439260763, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.3347982421093, 557.167035282253, 560.1793372708983, 570.6005795942835, 572.5877368294827, 27749.722502774966, 37190.442143367836, 38439.80780096095, 38526.0, 42082.36876446848, 38927.61072389275, 39202.0, 39207.41188882169, 39229.60770392295, 39283.41074883879, 7568.886466703004, 7714.884276735854, 7717.961410192969, 7719.49823261489, 7724.227577242259, 7290.453216008794, 7488.063992001, 7606.467547271694, 9621.711348659552, 9896.0, 9752.0, 9795.167410770093, 9798.265130115235, 9816.263780216512, 9819.067188617106, 9960.0, 10016.198704103726, 10016.749581260454, 10026.047525485068, 10027.79944401108, 9740.75648108796, 9815.0, 9823.410595364301, 9824.852627210597, 9829.0, 36150.0, 36509.817450912575, 36513.340432233046, 36539.26921461556, 36618.63381366179, 3065.846707664608, 3083.8612262448246, 3132.6710695376887, 3172.984135079333, 3186.7291280241207, 27516.312092197655, 27629.86185069082, 28254.858725706446, 28490.85754571214, 28524.0, 3483.3904066788464, 3490.5287786148797, 3494.109002204447, 3558.092686364986, 3638.1268495560876, 247235.0, 248676.0, 249052.0, 249053.0, 249563.9999999982, 51098.0, 51618.483815162115, 51655.22517162171, 51951.0, 52032.0, 53823.46176538184, 53920.460795392326, 53981.730091349295, 54037.72981135069, 54083.188752168746, 12875.806862897063, 13087.214767114003, 13096.476140954446, 13114.147580407243, 13121.278329691959, 9761.853572196424, 9876.851847222297, 9879.753006174904, 9917.107460328605, 9961.252906032076, 14359.497417590543, 14808.703825923421, 14846.628834279229, 14852.2573871306, 16241.918790405973, 5762.337331206965, 6333.809985700436, 6382.936170638327, 6422.45409140219, 6448.419642232222, 781.3241546062615, 820.5609998650693, 874.6938571499924, 929.8326301265702, 980.5146452505912, 25980.610290845652, 27158.321041974108, 27349.589756153673, 27382.726172738418, 27612.309692257855, 899.6221586933503, 906.207068814787, 908.7909780750465, 916.8991410944791, 941.8963913969458, 14149.434022639185, 14556.199409032393, 14573.417063317349, 14698.0, 14868.92565537187, 335985.0, 338681.0, 338856.0, 339497.0, 339848.0, 41776.37335439971, 42833.0, 48170.0, 48639.0, 48886.26670599944, 1115.4813011949482, 1130.4743294367993, 1154.342025045716, 1155.7977353963022, 1158.3050169898163, 27064.75222973256, 28263.858680707286, 28752.85623571869, 29209.415811683222, 29328.56007159937, 42019.7899010503, 42428.36357454579, 42543.3618495729, 42569.36145957875, 42658.78670606627, 314847.0, 522059.0, 537339.0, 537466.0, 537642.0, 24110.276691699277, 24113.056823351522, 24384.51230975406, 24460.75539244656, 24489.0, 40514.0, 40745.59254407418, 40928.386074209506, 41564.3765343514, 41845.163096737284, 34888.12779680528, 35209.0, 35280.47079293864, 35410.11474713153, 35433.46849797203, 34788.30423391569, 34815.47776783401, 34978.30043399067, 34998.650013500555, 35585.822070890514, 34418.0, 34714.0, 35052.29895402027, 35169.82415087908, 35426.0, 29521.409571808013, 31729.09625422482, 31884.0, 31891.840540797148, 32146.839265803523, 24333.026678932645, 24370.029342811125, 24442.755572444046, 24837.379065522782, 24902.252932412055], "value": 17479.27993382544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.49772257759406, 355.8043076308032, 356.20743844945, 360.5637179013394, 363.64362924334154, 12508.124431289802, 15526.301316440758, 15803.999999999985, 15885.602859928478, 16469.176541172925, 16065.518034458955, 16066.758998615001, 16863.91568042158, 16877.915610421962, 17031.659366812655, 4860.246661767432, 4915.926261106078, 5015.07221164084, 5054.9241761373605, 5070.467600901908, 3654.671079602835, 3855.2867719471847, 4954.900901981958, 5045.798168073273, 5046.697198168104, 3836.2135762168828, 3874.302625527404, 3883.184531248441, 3885.0675837798867, 4910.75446227689, 5792.073268277077, 5862.882742345172, 5870.941290587125, 5887.26409198848, 5887.322957859858, 5024.84925452237, 5074.340335756328, 5120.974395128001, 5194.480551944813, 5196.428392876781, 19531.0, 20014.599708005902, 20182.79817201824, 20246.392608221777, 20292.188312467482, 1945.3288615427655, 2027.5539381336082, 2257.119723307911, 2423.648570957201, 2466.8273220874366, 12705.936470317682, 12888.0, 13064.0, 13205.141665791789, 13338.466461341535, 1692.373821685984, 1698.4395149600603, 1733.6619359224956, 1736.6700326937842, 1763.4180720362249, 65438.67280663566, 65655.67172164157, 66227.0, 66451.335486645, 66993.66503167454, 9421.246300296098, 9487.430754154773, 9682.90317096834, 9683.770763787617, 9826.9017309826, 13008.154469959612, 13028.739425211443, 13047.151935124186, 13054.477820887058, 13061.281629510468, 6397.232332120176, 6637.900431493532, 6666.566673166229, 6738.797836064828, 6861.348171923659, 6218.22272215973, 6262.624242545462, 6416.839579010562, 6424.678766061678, 6428.067930150102, 5862.12068189775, 6074.908876366858, 6076.908846367308, 6130.601510901777, 6265.780697675559, 1611.7582362645696, 1655.8758093143063, 1655.9172041397883, 1697.7453381992552, 1744.9912750436167, 820.819419727659, 822.4243029879109, 868.4702331577732, 888.7022847346083, 894.4812009034745, 15381.9230903847, 16729.414470493473, 16941.830581694026, 17433.912830435765, 17484.737728934077, 815.4251252866715, 851.438050886412, 852.820907609409, 890.5814267294361, 905.515549181198, 9221.216196623362, 9776.804463910681, 9858.112769850748, 9873.210143188528, 9970.252231082697, 335974.0, 349869.0, 358396.0, 358801.61797573057, 360322.0, 44462.77768611136, 61333.69333153395, 62753.0, 66375.0, 70696.29303706897, 812.5043723328765, 826.7189155687096, 883.5449743382163, 931.4271722890373, 931.5528546297679, 14537.636559085684, 15519.146446945075, 16181.919090404472, 16233.51299461018, 16487.587810304838, 33493.0, 33543.664563354054, 34251.0, 34461.898429141496, 35458.645413545535, 42627.57372426236, 44332.33501497545, 44428.11143777171, 44901.0, 45258.77370613126, 4544.363789069599, 5044.1424957756535, 6105.603135796159, 7139.464540159405, 7189.424846012202, 11593.072554195813, 11617.186796924134, 11753.353565553976, 11805.0, 11917.52329906794, 10122.493875306352, 10291.485425728833, 10369.0, 10546.156307495536, 10742.409167495864, 10405.47972601382, 10450.634227801991, 10468.63359782404, 10474.581016759548, 10572.101371383518, 10224.539895704562, 10555.63055293061, 10630.468476576294, 10650.360978341325, 10966.958138976785, 7059.71761129549, 7164.319389657974, 7252.202257751748, 7381.335679788845, 7413.9258607415395, 9254.861177082485, 9913.702588922344, 9977.900220997697, 9988.550515226978, 10125.949370253102], "value": 7971.326741135682, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.4382315604291, 1333.7265860498599, 1367.2890097149482, 1591.427086248951, 1601.1593913195563, 6365.077063825748, 6680.933190668092, 6684.364985326386, 6697.2967838376935, 6702.430293425059, 5724.856878578038, 5984.341722410542, 6313.62118272904, 6493.577917435376, 6514.0, 1982.851286153537, 2015.8488113391481, 2022.29219773079, 2027.5539381336082, 2039.0212697905015, 1937.7577802774654, 2017.3645301729982, 2022.0294258755805, 2032.2886989553685, 2032.3090149349218, 1727.4299481171183, 1768.991155044223, 1885.9717104243448, 1927.7493925789627, 2000.9099590518388, 1945.173301346929, 1949.2885096939585, 1950.8634395592314, 1952.1117891359397, 1958.6768183249746, 1816.1827177770056, 1824.917878695462, 1849.9630007399912, 1992.2927360786857, 1996.3511858645998, 6684.732610695566, 6729.596224226513, 6851.07510486088, 6892.724291028353, 6926.619035953021, 4060.167665628539, 4193.811278492444, 4201.789910504463, 4203.516595591515, 4212.578742125794, 2594.8832302546243, 2789.790765692561, 2833.4474777418413, 2856.3144845237202, 2857.3713782967716, 845.5856630251194, 917.2661870503637, 919.3748251189189, 938.2962777916563, 944.7449188719007, 8581.184787445183, 8792.428492148054, 8812.647494100229, 8935.061818509093, 9004.784354112177, 3577.481265216529, 3615.665890123291, 3624.7643903146213, 3698.500702405141, 3710.888673339804, 7056.223815380304, 7059.682314295869, 7061.646917654097, 7067.5052746307265, 7075.186353569303, 4042.3532234842282, 4043.838246470108, 4044.170944956277, 4047.5952404759287, 4062.979685101615, 3808.0, 3808.5239345081864, 3808.847646094125, 3815.122521819997, 3817.2938006468335, 2949.3953739483354, 3046.116626178428, 3070.2938324185116, 3087.228192951762, 3089.567460555524, 916.083916083916, 921.755734730297, 926.5228407370209, 926.8517037274004, 949.534727983297, 719.7408932784193, 725.9147574376341, 740.1968863782748, 746.1307576673223, 751.2637615137087, 4404.273294906305, 4424.6902716810155, 4478.350639157304, 4604.470485894098, 4609.216433206363, 744.4528271720282, 751.2675141736872, 753.2241790955325, 766.2605585609801, 766.6626684258908, 2926.443975644621, 2954.5715871198554, 2991.730744232986, 3043.832589207615, 3108.0675797260733, 7622.0, 7910.367170626336, 7920.247576480225, 8170.387220958333, 8195.0, 8136.55248961301, 8137.796555086052, 8138.837223255502, 8145.959270203611, 8148.796280092926, 6316.084167795644, 6433.324500927335, 6435.710393032325, 6466.773662921869, 6475.287718351072, 4351.543087975843, 4358.4769827620885, 4362.629176520031, 4379.098269109521, 4509.729416235036, 7372.115346158495, 7589.886151707839, 7706.807329816799, 7759.7672069838, 7766.534007959541, 7678.731244406419, 7763.184865589032, 7791.610419479117, 7800.687972481264, 7812.804679883048, 5874.236349274567, 6051.75792968294, 6053.818385448443, 6054.061620448838, 6055.939440605537, 6110.450059494667, 6130.601510901777, 6164.506839452743, 6176.969115154575, 6178.289496707936, 5788.21859049023, 5794.0439827428, 5840.591158618856, 5860.853478663067, 5909.379515151019, 5707.286589176353, 5809.186713859978, 5879.617824841372, 5951.315598706031, 5981.730822112929, 5483.588730845123, 5536.889262214814, 5565.9721701392855, 5571.13647384656, 5571.13647384656, 4057.959420405758, 4064.1465292287767, 4065.329220678673, 4134.049168691157, 4229.788510574397, 3855.132595166065, 3863.24666690004, 3895.902602434962, 3920.4707364505425, 3921.5490218625223], "value": 3603.0990792414873, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.12237901618442, 255.20758046266343, 265.84182411465184, 274.71155286948704, 280.60154580495686, 4692.577668009879, 4795.616350691941, 4874.756262186894, 4896.926546101811, 4907.423602608632, 4739.5023522530155, 4746.3117847912035, 4773.785179666915, 4799.68802027868, 4828.275758636207, 3625.329314076891, 3776.1503661676043, 3812.618738126179, 3816.313063648542, 3821.7515861468914, 3565.450702747535, 3670.724695647837, 3678.393065144248, 3745.6441638044344, 3787.3561494545856, 3749.531308586427, 3756.6663834338824, 3762.7177961652988, 3769.623037696222, 3771.2080463102643, 3741.120836603396, 3742.532183477079, 3764.4353346997896, 3768.340540405418, 3798.974276945237, 3156.9684303157132, 3245.7666086887066, 3259.5110733389943, 3316.2041110133637, 3332.766706330558, 4699.355225671022, 4717.2452407614965, 4732.905341893177, 4743.980044290494, 4768.976155119202, 4285.764282964436, 4306.397104405386, 4312.353147027971, 4333.0, 4336.761478118702, 4817.807287708488, 5022.42242142151, 5039.571636410909, 5043.36957880265, 5051.090803655341, 3606.855725770966, 3617.8371973261005, 3624.586411299595, 3627.528421305213, 3631.0740761106013, 5305.65513241638, 5322.175062865262, 5335.7865685372535, 5346.599005074635, 5352.304200453916, 3713.814309284579, 3741.120836603396, 3744.7940363279736, 3747.2880152770886, 3750.681192098702, 3570.250247448013, 3724.1434470072036, 3760.3983362661843, 3763.717721170923, 3766.981165094157, 4034.636882680573, 4098.692598055158, 4128.0, 4239.618434340862, 4294.3558466230315, 4991.825286115041, 5014.222795466709, 5020.748962551857, 5030.7233102179, 5040.873978150576, 1231.4396949388006, 1242.6641360537458, 1251.7121062155754, 1257.9874201258053, 1273.6943133647858, 826.8098337382436, 867.0635713429481, 869.452245085592, 879.8372301124313, 884.0584777212248, 4288.399624052635, 4308.728924967142, 4353.673474489426, 4354.891127721832, 4359.934600980988, 5008.0, 5020.648554601216, 5050.747462626854, 5064.354084922415, 5114.539691427789, 4325.6106950374615, 4347.2176407672705, 4348.173846969065, 4357.694961352739, 4363.759993200404, 2546.675728621107, 2664.786817054631, 2693.0, 2707.6073969274344, 2709.618094771641, 4789.257665061921, 4811.78346974387, 4812.951870481251, 4813.253945638432, 4834.20235661119, 4910.975445122752, 5134.409542902539, 5195.298634684269, 5199.766010529535, 5215.739213039333, 4796.496367881392, 4802.399700037496, 4807.831725889507, 4835.854924352275, 4848.612111031109, 5093.18509038552, 5093.567046800915, 5102.285680004877, 5114.923276150935, 5120.769565369493, 4891.51084891508, 4999.500049994971, 5005.874853128701, 5022.347094877642, 5030.622703297194, 4971.0, 4984.4517103117905, 4991.2565575818135, 4991.650584459053, 4992.1529034257555, 3617.6924961377526, 3621.0766254604905, 3630.528031355907, 3635.5092062571216, 3637.636236376341, 4983.775730092227, 5043.773030213576, 5312.309399778004, 5322.228276899906, 5325.573954083741, 5075.695458272516, 5102.387713474407, 5102.4897510248675, 5103.591712663052, 5107.10625640504, 5122.667026643257, 5125.0, 5138.820141295037, 5145.919356934935, 5147.819826306061, 4868.513148685245, 5007.799688012438, 5039.672421292605, 5055.634978555843, 5065.39215294167, 5139.353233085039, 5162.019216349032, 5166.560842328444, 5170.484070831871, 5171.896562068662, 4952.656956554383, 5023.4725353838785, 5028.0, 5028.823991160292, 5047.242913562848], "value": 3777.6301074996554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.8435206846219, 670.2593634034395, 678.8167194857392, 695.3950063444802, 698.4552049401468, 11411.25826821257, 11583.768324633502, 11619.12856535761, 11642.06863450924, 11677.124215683814, 13022.479100835979, 13193.34033298336, 13207.273599952, 13237.801432978513, 13250.271235082068, 593.264352203267, 609.1928195141434, 721.293132729925, 740.7407407407418, 747.977560673178, 742.610129681916, 751.0649241694099, 752.2101793117232, 752.5559919647407, 753.446217030485, 791.3589992106412, 793.1434051224663, 796.8286818334057, 797.3262593108843, 798.2217338095339, 625.5089754542662, 642.502060902804, 766.8044648614623, 782.2803021220491, 797.0117054851971, 584.1267305378444, 584.3426145586216, 584.8742520358101, 584.9327327357323, 585.0697391148052, 11777.58778442759, 11778.057755379548, 11778.057755379548, 11807.996320312785, 11812.940935295355, 12075.637730868088, 12200.511979520808, 12572.30852303132, 12603.810942835864, 12661.746765064647, 9607.663731769355, 11266.267692599955, 11383.260088094248, 11758.17692761507, 11759.0, 3166.335069635379, 3184.1243657994237, 3257.3973814844094, 3388.5594872666643, 4007.9599204007877, 64998.350016500175, 65008.674956625386, 66736.66631666859, 67605.66197169032, 67761.66119169422, 9132.908670913339, 9596.088371604686, 9632.422054676741, 9705.805883882424, 9874.308798384043, 18143.909280453514, 18166.727499087523, 18184.0, 18282.0, 18372.448826535227, 6242.0, 6287.182666253358, 6422.935770642233, 6433.388828061326, 6493.0, 3458.706009989179, 3506.263684626206, 3525.823708814549, 3557.1107223194203, 3583.0, 2691.4751623433635, 2760.144355249839, 2787.9024234151707, 2793.050362876632, 2795.6086147939304, 449.42249209765293, 450.981960721574, 454.1779379323435, 455.37840847243274, 457.61560289356436, 463.9605633521121, 533.4425525326044, 533.8104972734624, 537.2914133056917, 565.9236003139606, 7680.692772289158, 8010.198980101944, 8091.757247282591, 8263.917360826435, 8329.708460203863, 552.4475524475524, 561.166667498764, 566.9971650141723, 571.0919637775957, 576.1214148423604, 3756.9812150939615, 3996.2407142642805, 4060.4112403701297, 4527.796249168795, 4554.3851580036935, 64207.35792642107, 64922.0, 65921.82680723668, 67321.32678673249, 69912.30087699057, 54630.45369546333, 54783.726081370136, 55538.16692749612, 56392.71803641038, 57566.560835979435, 53076.20385694218, 53379.73310133425, 54064.729676351366, 55004.0, 55191.448085519434, 8625.568721564023, 9106.453612783254, 9190.221428892022, 9201.953990230273, 9262.65691474719, 35901.461478078374, 37424.0, 37497.062573435884, 37721.43417848789, 38558.6144138555, 44642.776786115865, 47898.0, 49407.25889111594, 49780.0, 51419.74290128525, 10474.371537707762, 10638.41488718128, 10718.14254859625, 10807.891921081004, 10848.077913377452, 12438.751224975269, 12843.0, 12846.743065138458, 12950.93524532409, 13109.475620975054, 9307.0, 11347.773044539228, 11612.0, 12065.698357540781, 12714.235312240948, 11842.644720658394, 12019.819702704292, 12184.329861857683, 12185.268883866996, 12852.485900563872, 11163.944180279046, 11612.575812606916, 11711.297322160697, 12106.576269830513, 12609.180403273758, 9626.422414655142, 9853.261005424765, 9905.15806156456, 9911.45486998222, 10279.229057820543, 9987.800243995225, 10064.39613623185, 10074.949625251827, 10308.948455257676, 10335.121514671337], "value": 6146.825371769013, "unit": "score"}], "name": "dromaeo_css", "value": 6130.541821749177, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 116.0, 116.0, 116.0, 119.0, 117.0, 118.0, 118.0, 115.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 140.0, 167.0, 140.0, 132.0, 136.0, 130.0, 157.0, 139.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 162.0, 164.0, 161.0, 161.0, 162.0, 162.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 111.0, 78.0, 76.0, 76.0, 86.0, 92.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 103.0, 84.0, 84.0, 84.0, 104.0, 84.0, 84.0, 100.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 64.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 68.0, 66.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 86.0, 85.0, 85.0, 85.0, 84.0, 86.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 154.0, 144.0, 152.0, 145.0, 142.0, 143.0, 140.0, 181.0, 143.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 181.0, 181.0, 180.0, 183.0, 187.0, 183.0, 180.0, 187.0], "value": 182.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 72.0, 71.0, 71.0, 72.0, 71.0, 72.0, 70.0, 72.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1573.0000000000002, "alertThreshold": 2.0}]} 09:13:44 INFO - Return code: 0 09:13:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:13:44 INFO - # TBPL SUCCESS # 09:13:44 INFO - Running post-action listener: _resource_record_post_action 09:13:44 INFO - [mozharness: 2016-11-28 17:13:44.604027Z] Finished run-tests step (success) 09:13:44 INFO - Running post-run listener: _resource_record_post_run 09:13:44 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 389398528; Read time: 16; Write time: 335348 09:13:44 INFO - TinderboxPrint: CPU usage
13.1% 09:13:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:13:44 INFO - TinderboxPrint: I/O write bytes / time
389,398,528 / 335,348 09:13:44 INFO - TinderboxPrint: CPU idle
8,361.2 (86.9%) 09:13:44 INFO - TinderboxPrint: CPU user
1,210.8 (12.6%) 09:13:44 INFO - TinderboxPrint: Swap in / out
0 / 0 09:13:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99872768; Read time: 0; Write time: 112392 09:13:44 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 289525760; Read time: 0; Write time: 222956 09:13:45 INFO - Running post-run listener: _upload_blobber_files 09:13:45 INFO - Blob upload gear active. 09:13:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:45 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 09:13:45 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'] 09:13:45 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 09:13:45 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:13:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:13:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:46 INFO - (blobuploader) - INFO - Done attempting. 09:13:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:13:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:13:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:51 INFO - (blobuploader) - INFO - Done attempting. 09:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:52 INFO - (blobuploader) - INFO - Done attempting. 09:13:52 INFO - (blobuploader) - INFO - Iteration through files over. 09:13:52 INFO - Return code: 0 09:13:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:13:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:13:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30267039dd715ab48bfe3007e7c589c05945bedd9d9759fc0bc7428c1e415b731db955883ec3611bbedf3a9855616f4a81c2193ca37904ec68b78c05b10198c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8907ce07f11700015533e8c533a5bcbc9c1ce8517c5cd1b0527d236a2f1cd398daf3fd89940be548259026b6aaa2f375a5c282547e0d5b261f68bb4713301b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa49963af69f020dc86943942e4938abe1b93aeb54cd726a31a5a9016473f3d504b41127904b0084a46b42869495f6b12f7506c002e5474d706b047f1dc9cb28"} 09:13:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:13:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:13:52 INFO - Contents: 09:13:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30267039dd715ab48bfe3007e7c589c05945bedd9d9759fc0bc7428c1e415b731db955883ec3611bbedf3a9855616f4a81c2193ca37904ec68b78c05b10198c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8907ce07f11700015533e8c533a5bcbc9c1ce8517c5cd1b0527d236a2f1cd398daf3fd89940be548259026b6aaa2f375a5c282547e0d5b261f68bb4713301b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa49963af69f020dc86943942e4938abe1b93aeb54cd726a31a5a9016473f3d504b41127904b0084a46b42869495f6b12f7506c002e5474d706b047f1dc9cb28"} 09:13:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:13:52 INFO - Copying logs to upload dir... 09:13:52 INFO - mkdir: /builds/slave/test/build/upload/logs 09:13:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.103850 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-28 09:13:51.107307) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 09:13:51.111331) ========= 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=cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819 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/30267039dd715ab48bfe3007e7c589c05945bedd9d9759fc0bc7428c1e415b731db955883ec3611bbedf3a9855616f4a81c2193ca37904ec68b78c05b10198c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8907ce07f11700015533e8c533a5bcbc9c1ce8517c5cd1b0527d236a2f1cd398daf3fd89940be548259026b6aaa2f375a5c282547e0d5b261f68bb4713301b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa49963af69f020dc86943942e4938abe1b93aeb54cd726a31a5a9016473f3d504b41127904b0084a46b42869495f6b12f7506c002e5474d706b047f1dc9cb28"} build_url:https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/flNUMuIXRfGQ8NGuLlHgYg/artifacts/public/build/firefox-53.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/30267039dd715ab48bfe3007e7c589c05945bedd9d9759fc0bc7428c1e415b731db955883ec3611bbedf3a9855616f4a81c2193ca37904ec68b78c05b10198c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8907ce07f11700015533e8c533a5bcbc9c1ce8517c5cd1b0527d236a2f1cd398daf3fd89940be548259026b6aaa2f375a5c282547e0d5b261f68bb4713301b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa49963af69f020dc86943942e4938abe1b93aeb54cd726a31a5a9016473f3d504b41127904b0084a46b42869495f6b12f7506c002e5474d706b047f1dc9cb28"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 09:13:51.137086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 09:13:51.137423) ========= 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=cbe409c6de289db6ac707de3000001d4-1480351158.177389-896829819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 09:13:51.223054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 09:13:51.223381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 09:13:51.223705) ========= ========= Total master_lag: 0.16 =========