builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1478878636.26 results: success (0) buildid: 20161111062119 builduid: 72d4136e882c499d86b2739ae5ca6b7d revision: bf3c647eec8100c19efd5ba415686bfd0854c113 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:16.262954) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:16.263406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:16.263701) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:16.278490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:16.278786) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-11 07:37:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2016-11-11 07:37:16 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:16.425709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:16.425992) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021424 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:16.475566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:16.475888) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bf3c647eec8100c19efd5ba415686bfd0854c113 --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 bf3c647eec8100c19efd5ba415686bfd0854c113 --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=20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-11 07:37:16,956 truncating revision to first 12 chars 2016-11-11 07:37:16,956 Setting DEBUG logging. 2016-11-11 07:37:16,956 attempt 1/10 2016-11-11 07:37:16,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bf3c647eec81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 07:37:17,258 unpacking tar archive at: mozilla-central-bf3c647eec81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622694 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:17.111393) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:17.111683) ========= script_repo_revision: bf3c647eec8100c19efd5ba415686bfd0854c113 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:17.112077) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:17.112395) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 07:37:17.122864) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-11 07:37:17.123168) ========= /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=20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:17 INFO - MultiFileLogger online at 20161111 07:37:17 in /builds/slave/test 07:37:17 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 07:37:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:17 INFO - {'append_to_log': False, 07:37:17 INFO - 'base_work_dir': '/builds/slave/test', 07:37:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:37:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:17 INFO - 'branch': 'Firefox-Non-PGO', 07:37:17 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:17 INFO - 'config_files': ('talos/linux_config.py',), 07:37:17 INFO - 'default_actions': ('clobber', 07:37:17 INFO - 'read-buildbot-config', 07:37:17 INFO - 'download-and-extract', 07:37:17 INFO - 'populate-webroot', 07:37:17 INFO - 'create-virtualenv', 07:37:17 INFO - 'install', 07:37:17 INFO - 'run-tests'), 07:37:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:17 INFO - 'download_minidump_stackwalk': True, 07:37:17 INFO - 'download_symbols': 'ondemand', 07:37:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:17 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:17 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:17 INFO - 'installer_path': 'installer.exe', 07:37:17 INFO - 'log_level': 'info', 07:37:17 INFO - 'log_name': 'talos', 07:37:17 INFO - 'log_to_console': True, 07:37:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:17 INFO - 'opt_config_files': (), 07:37:17 INFO - 'pip_index': False, 07:37:17 INFO - 'sps_profile': False, 07:37:17 INFO - 'sps_profile_interval': 0, 07:37:17 INFO - 'suite': 'dromaeojs', 07:37:17 INFO - 'system_bits': '32', 07:37:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:17 INFO - 'title': 'talos-linux64-ix-015', 07:37:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:17 INFO - 'use_talos_json': True, 07:37:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:17 INFO - 'work_dir': 'build'} 07:37:17 INFO - [mozharness: 2016-11-11 15:37:17.700043Z] Running clobber step. 07:37:17 INFO - Running pre-action listener: _resource_record_pre_action 07:37:17 INFO - Running main action method: clobber 07:37:17 INFO - rmtree: /builds/slave/test/build 07:37:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:18 INFO - Running post-action listener: _resource_record_post_action 07:37:18 INFO - [mozharness: 2016-11-11 15:37:18.666572Z] Finished clobber step (success) 07:37:18 INFO - [mozharness: 2016-11-11 15:37:18.666671Z] Running read-buildbot-config step. 07:37:18 INFO - Running pre-action listener: _resource_record_pre_action 07:37:18 INFO - Running main action method: read_buildbot_config 07:37:18 INFO - Using buildbot properties: 07:37:18 INFO - { 07:37:18 INFO - "project": "", 07:37:18 INFO - "product": "firefox", 07:37:18 INFO - "script_repo_revision": "production", 07:37:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:37:18 INFO - "repository": "", 07:37:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:37:18 INFO - "buildid": "20161111062119", 07:37:18 INFO - "pgo_build": "False", 07:37:18 INFO - "basedir": "/builds/slave/test", 07:37:18 INFO - "buildnumber": 296, 07:37:18 INFO - "slavename": "talos-linux64-ix-015", 07:37:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:37:18 INFO - "platform": "ubuntu64_hw", 07:37:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:37:18 INFO - "branch": "mozilla-central", 07:37:18 INFO - "repo_path": "mozilla-central", 07:37:18 INFO - "revision": "bf3c647eec8100c19efd5ba415686bfd0854c113", 07:37:18 INFO - "stage_platform": "linux64", 07:37:18 INFO - "builduid": "72d4136e882c499d86b2739ae5ca6b7d", 07:37:18 INFO - "slavebuilddir": "test" 07:37:18 INFO - } 07:37:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:37:18 INFO - Running post-action listener: _resource_record_post_action 07:37:18 INFO - [mozharness: 2016-11-11 15:37:18.669125Z] Finished read-buildbot-config step (success) 07:37:18 INFO - [mozharness: 2016-11-11 15:37:18.669219Z] Running download-and-extract step. 07:37:18 INFO - Running pre-action listener: _resource_record_pre_action 07:37:18 INFO - Running main action method: download_and_extract 07:37:18 INFO - mkdir: /builds/slave/test/build/tests 07:37: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')]} 07:37:18 INFO - trying https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:37:18 INFO - Downloading https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:37:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:37:19 INFO - Downloaded 1361 bytes. 07:37:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:37:19 INFO - Using the following test package requirements: 07:37:19 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:19 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:37:19 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:37:19 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:19 INFO - u'jsshell-linux-x86_64.zip'], 07:37:19 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:37:19 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:19 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:37:19 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:37:19 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:37:19 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:37:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:37:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:37:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:19 INFO - Fetch https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:37:19 INFO - Http code: 200 07:37:19 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 07:37:19 INFO - x-amz-cf-id: qKe02zXuGC3Irqamfne16VnSLpv0efsoegnhHpp42RNocXtJET6_YQ== 07:37:19 INFO - x-amz-version-id: UsMAjq6HR3QwFW3x8Jz87zgoIa2oxKq. 07:37:20 INFO - Expected file size: 20414063 07:37:20 INFO - Obtained file size: 20414063 07:37:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:37:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:37:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:24 INFO - Fetch https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:37:24 INFO - Http code: 200 07:37:24 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 07:37:24 INFO - x-amz-cf-id: mkHg2s9yvtzMDjPggBhI3F-7KX37jyfT4Wt1YwDeWSc7zt0Ok5z2gg== 07:37:24 INFO - x-amz-version-id: UsMAjq6HR3QwFW3x8Jz87zgoIa2oxKq. 07:37:24 INFO - Expected file size: 20414063 07:37:24 INFO - Obtained file size: 20414063 07:37:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:37:29 INFO - Fetch https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:37:29 INFO - Http code: 200 07:37:29 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 07:37:29 INFO - x-amz-cf-id: H0TF62MrmKmZkIhG-ws3BpHPwVeTHbCzdQpmb8y8weagLdQT4LS1Nw== 07:37:29 INFO - x-amz-version-id: U.dzAUS9kIEdhrS107o15TMDTiovAZA_ 07:37:30 INFO - Expected file size: 14409038 07:37:30 INFO - Obtained file size: 14409038 07:37: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')]} 07:37:30 INFO - trying https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:37:30 INFO - Downloading https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:37:32 INFO - Downloaded 55697474 bytes. 07:37:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:37:32 INFO - mkdir: /builds/slave/test/properties 07:37:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:32 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:32 INFO - Contents: 07:37:32 INFO - build_url:https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:37:32 INFO - Running post-action listener: _resource_record_post_action 07:37:32 INFO - Running post-action listener: set_extra_try_arguments 07:37:32 INFO - [mozharness: 2016-11-11 15:37:32.607510Z] Finished download-and-extract step (success) 07:37:32 INFO - [mozharness: 2016-11-11 15:37:32.607737Z] Running populate-webroot step. 07:37:32 INFO - Running pre-action listener: _resource_record_pre_action 07:37:32 INFO - Running main action method: populate_webroot 07:37:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:32 INFO - '--tppagecycles', 07:37:32 INFO - '7'], 07:37:32 INFO - 'tests': ['tsvgm']}}, 07:37:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['damp', 'tps']}, 07:37:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'tests': ['damp', 'tps']}, 07:37:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['dromaeo_dom']}, 07:37:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['basic_compositor_video']}, 07:37:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tsvgx', 07:37:32 INFO - 'tsvgr_opacity', 07:37:32 INFO - 'tart', 07:37:32 INFO - 'tscrollx', 07:37:32 INFO - 'cart']}, 07:37:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:32 INFO - 'tsvgr_opacity', 07:37:32 INFO - 'tart', 07:37:32 INFO - 'tscrollx', 07:37:32 INFO - 'cart']}, 07:37:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tp5o']}, 07:37:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'tests': ['tp5o']}, 07:37:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s', 07:37:32 INFO - '--xperf_path', 07:37:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:32 INFO - 'tests': ['tp5n']}, 07:37:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:32 INFO - 'talos_options': ['--xperf_path', 07:37:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:32 INFO - 'tests': ['tp5n']}}, 07:37:32 INFO - 'talos.zip': {'path': '', 07:37:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:32 INFO - Running post-action listener: _resource_record_post_action 07:37:32 INFO - [mozharness: 2016-11-11 15:37:32.631884Z] Finished populate-webroot step (success) 07:37:32 INFO - [mozharness: 2016-11-11 15:37:32.631972Z] Running create-virtualenv step. 07:37:32 INFO - Running pre-action listener: _resource_record_pre_action 07:37:32 INFO - Running main action method: create_virtualenv 07:37:32 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:32 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 07:37:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:32 INFO - Using real prefix '/usr' 07:37:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:35 INFO - Installing pip.................done. 07:37:35 INFO - Return code: 0 07:37:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:37:35 INFO - Reading from file tmpfile_stdout 07:37:35 INFO - Output received: 07:37:35 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) 07:37:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:35 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 0x7fd1579fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', '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 07:37:35 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 07:37:35 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 07:37:35 INFO - Using env: {'DISPLAY': ':0', 07:37:35 INFO - 'HOME': '/home/cltbld', 07:37:35 INFO - 'LANG': 'en_US.UTF-8', 07:37:35 INFO - 'LANGUAGE': 'en_US:en', 07:37:35 INFO - 'LOGNAME': 'cltbld', 07:37:35 INFO - 'MAIL': '/var/mail/cltbld', 07:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:35 INFO - 'MOZ_NO_REMOTE': '1', 07:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:35 INFO - 'NO_EM_RESTART': '1', 07:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:35 INFO - 'PWD': '/builds/slave/test', 07:37:35 INFO - 'SHELL': '/bin/bash', 07:37:35 INFO - 'SHLVL': '1', 07:37:35 INFO - 'TERM': 'linux', 07:37:35 INFO - 'TMOUT': '86400', 07:37:35 INFO - 'USER': 'cltbld', 07:37:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:35 INFO - '_': '/tools/buildbot/bin/python'} 07:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:35 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 07:37:35 INFO - Cleaning up... 07:37:35 INFO - Return code: 0 07:37:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:35 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 0x7fd1579fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', '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 07:37:35 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 07:37:35 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 07:37:35 INFO - Using env: {'DISPLAY': ':0', 07:37:35 INFO - 'HOME': '/home/cltbld', 07:37:35 INFO - 'LANG': 'en_US.UTF-8', 07:37:35 INFO - 'LANGUAGE': 'en_US:en', 07:37:35 INFO - 'LOGNAME': 'cltbld', 07:37:35 INFO - 'MAIL': '/var/mail/cltbld', 07:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:35 INFO - 'MOZ_NO_REMOTE': '1', 07:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:35 INFO - 'NO_EM_RESTART': '1', 07:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:35 INFO - 'PWD': '/builds/slave/test', 07:37:35 INFO - 'SHELL': '/bin/bash', 07:37:35 INFO - 'SHLVL': '1', 07:37:35 INFO - 'TERM': 'linux', 07:37:35 INFO - 'TMOUT': '86400', 07:37:35 INFO - 'USER': 'cltbld', 07:37:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:35 INFO - '_': '/tools/buildbot/bin/python'} 07:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:35 INFO - Downloading/unpacking psutil>=3.1.1 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:37 INFO - Installing collected packages: psutil 07:37:37 INFO - Running setup.py install for psutil 07:37:37 INFO - building 'psutil._psutil_linux' extension 07:37:37 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 07:37:38 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 07:37:38 INFO - building 'psutil._psutil_posix' extension 07:37:38 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 07:37:38 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 07:37:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:38 INFO - Successfully installed psutil 07:37:38 INFO - Cleaning up... 07:37:38 INFO - Return code: 0 07:37:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1579fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', '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 07:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:37: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 mozsystemmonitor==0.3 07:37:38 INFO - Using env: {'DISPLAY': ':0', 07:37:38 INFO - 'HOME': '/home/cltbld', 07:37:38 INFO - 'LANG': 'en_US.UTF-8', 07:37:38 INFO - 'LANGUAGE': 'en_US:en', 07:37:38 INFO - 'LOGNAME': 'cltbld', 07:37:38 INFO - 'MAIL': '/var/mail/cltbld', 07:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:38 INFO - 'MOZ_NO_REMOTE': '1', 07:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:38 INFO - 'NO_EM_RESTART': '1', 07:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:38 INFO - 'PWD': '/builds/slave/test', 07:37:38 INFO - 'SHELL': '/bin/bash', 07:37:38 INFO - 'SHLVL': '1', 07:37:38 INFO - 'TERM': 'linux', 07:37:38 INFO - 'TMOUT': '86400', 07:37:38 INFO - 'USER': 'cltbld', 07:37:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:38 INFO - '_': '/tools/buildbot/bin/python'} 07:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:37:40 INFO - Installing collected packages: mozsystemmonitor 07:37:40 INFO - Running setup.py install for mozsystemmonitor 07:37:40 INFO - Successfully installed mozsystemmonitor 07:37:40 INFO - Cleaning up... 07:37:40 INFO - Return code: 0 07:37:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 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 0x7fd1579fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', '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 07:37:40 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 07:37:40 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 07:37:40 INFO - Using env: {'DISPLAY': ':0', 07:37:40 INFO - 'HOME': '/home/cltbld', 07:37:40 INFO - 'LANG': 'en_US.UTF-8', 07:37:40 INFO - 'LANGUAGE': 'en_US:en', 07:37:40 INFO - 'LOGNAME': 'cltbld', 07:37:40 INFO - 'MAIL': '/var/mail/cltbld', 07:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:40 INFO - 'MOZ_NO_REMOTE': '1', 07:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:40 INFO - 'NO_EM_RESTART': '1', 07:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:40 INFO - 'PWD': '/builds/slave/test', 07:37:40 INFO - 'SHELL': '/bin/bash', 07:37:40 INFO - 'SHLVL': '1', 07:37:40 INFO - 'TERM': 'linux', 07:37:40 INFO - 'TMOUT': '86400', 07:37:40 INFO - 'USER': 'cltbld', 07:37:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:40 INFO - '_': '/tools/buildbot/bin/python'} 07:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:41 INFO - Downloading/unpacking jsonschema==2.5.1 07:37:41 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 07:37:41 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 07:37:41 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 07:37:41 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 07:37:41 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 07:37:41 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 07:37:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:37:42 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 07:37:42 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 07:37:42 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 07:37:42 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 07:37:42 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 07:37:42 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 07:37:43 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:43 INFO - warning: no files found matching '*.txt' 07:37:43 INFO - no previously-included directories found matching 'build' 07:37:43 INFO - no previously-included directories found matching 'dist' 07:37:43 INFO - no previously-included directories found matching '.git*' 07:37:43 INFO - Installing collected packages: jsonschema, functools32 07:37:43 INFO - Running setup.py install for functools32 07:37:43 INFO - warning: no files found matching '*.txt' 07:37:43 INFO - no previously-included directories found matching 'build' 07:37:43 INFO - no previously-included directories found matching 'dist' 07:37:43 INFO - no previously-included directories found matching '.git*' 07:37:43 INFO - Successfully installed jsonschema functools32 07:37:43 INFO - Cleaning up... 07:37:43 INFO - Return code: 0 07:37:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:37:43 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')]} 07:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:43 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')]} 07:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:43 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 0x7fd1579fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', '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 07:37:43 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 07:37:43 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 07:37:43 INFO - Using env: {'DISPLAY': ':0', 07:37:43 INFO - 'HOME': '/home/cltbld', 07:37:43 INFO - 'LANG': 'en_US.UTF-8', 07:37:43 INFO - 'LANGUAGE': 'en_US:en', 07:37:43 INFO - 'LOGNAME': 'cltbld', 07:37:43 INFO - 'MAIL': '/var/mail/cltbld', 07:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:43 INFO - 'MOZ_NO_REMOTE': '1', 07:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:43 INFO - 'NO_EM_RESTART': '1', 07:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:43 INFO - 'PWD': '/builds/slave/test', 07:37:43 INFO - 'SHELL': '/bin/bash', 07:37:43 INFO - 'SHLVL': '1', 07:37:43 INFO - 'TERM': 'linux', 07:37:43 INFO - 'TMOUT': '86400', 07:37:43 INFO - 'USER': 'cltbld', 07:37:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:43 INFO - '_': '/tools/buildbot/bin/python'} 07:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:37:43 INFO - Cleaning up... 07:37:43 INFO - Return code: 0 07:37:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:43 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')]} 07:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:43 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')]} 07:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:43 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 0x7fd1579fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', '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 07:37:43 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 07:37:43 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 07:37:43 INFO - Using env: {'DISPLAY': ':0', 07:37:43 INFO - 'HOME': '/home/cltbld', 07:37:43 INFO - 'LANG': 'en_US.UTF-8', 07:37:43 INFO - 'LANGUAGE': 'en_US:en', 07:37:43 INFO - 'LOGNAME': 'cltbld', 07:37:43 INFO - 'MAIL': '/var/mail/cltbld', 07:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:43 INFO - 'MOZ_NO_REMOTE': '1', 07:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:43 INFO - 'NO_EM_RESTART': '1', 07:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:43 INFO - 'PWD': '/builds/slave/test', 07:37:43 INFO - 'SHELL': '/bin/bash', 07:37:43 INFO - 'SHLVL': '1', 07:37:43 INFO - 'TERM': 'linux', 07:37:43 INFO - 'TMOUT': '86400', 07:37:43 INFO - 'USER': 'cltbld', 07:37:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:43 INFO - '_': '/tools/buildbot/bin/python'} 07:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:43 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:43 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 07:37:43 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 07:37:43 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 07:37:43 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 07:37:43 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 07:37:43 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 07:37:45 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:45 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 07:37:45 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 07:37:45 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 07:37:45 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 07:37:45 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 07:37:45 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 07:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:46 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 07:37:46 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 07:37:46 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 07:37:46 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 07:37:46 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 07:37:46 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 07:37:46 INFO - Downloading docopt-0.6.1.tar.gz 07:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:46 INFO - Running setup.py install for blobuploader 07:37:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:46 INFO - Running setup.py install for requests 07:37:47 INFO - Running setup.py install for docopt 07:37:47 INFO - Successfully installed blobuploader requests docopt 07:37:47 INFO - Cleaning up... 07:37:47 INFO - Return code: 0 07:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:47 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')]} 07:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:47 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')]} 07:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:47 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 0x7fd1579fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', '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 07:37:47 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 07:37:47 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 07:37:47 INFO - Using env: {'DISPLAY': ':0', 07:37:47 INFO - 'HOME': '/home/cltbld', 07:37:47 INFO - 'LANG': 'en_US.UTF-8', 07:37:47 INFO - 'LANGUAGE': 'en_US:en', 07:37:47 INFO - 'LOGNAME': 'cltbld', 07:37:47 INFO - 'MAIL': '/var/mail/cltbld', 07:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:47 INFO - 'MOZ_NO_REMOTE': '1', 07:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:47 INFO - 'NO_EM_RESTART': '1', 07:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:47 INFO - 'PWD': '/builds/slave/test', 07:37:47 INFO - 'SHELL': '/bin/bash', 07:37:47 INFO - 'SHLVL': '1', 07:37:47 INFO - 'TERM': 'linux', 07:37:47 INFO - 'TMOUT': '86400', 07:37:47 INFO - 'USER': 'cltbld', 07:37:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:47 INFO - '_': '/tools/buildbot/bin/python'} 07:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:47 INFO - Running setup.py (path:/tmp/pip-VcsoD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:47 INFO - Running setup.py (path:/tmp/pip-QvoLqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:47 INFO - Running setup.py (path:/tmp/pip-hdaoaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:47 INFO - Running setup.py (path:/tmp/pip-HlB7zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:47 INFO - Running setup.py (path:/tmp/pip-2taKTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:47 INFO - Running setup.py (path:/tmp/pip-x6hvQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:47 INFO - Running setup.py (path:/tmp/pip-bN06_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:47 INFO - Running setup.py (path:/tmp/pip-yxtkqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:47 INFO - Running setup.py (path:/tmp/pip-ai7UF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:48 INFO - Running setup.py (path:/tmp/pip-oQr13I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:48 INFO - Running setup.py (path:/tmp/pip-fONVae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:48 INFO - Running setup.py (path:/tmp/pip-1SjCQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:48 INFO - Running setup.py (path:/tmp/pip-9a1fLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:48 INFO - Running setup.py (path:/tmp/pip-YJGEuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:48 INFO - Running setup.py (path:/tmp/pip-9P_S4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:48 INFO - Running setup.py (path:/tmp/pip-fj_lLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:48 INFO - Running setup.py (path:/tmp/pip-GGjcRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:48 INFO - Running setup.py install for manifestparser 07:37:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:48 INFO - Running setup.py install for mozcrash 07:37:48 INFO - Running setup.py install for mozdebug 07:37:48 INFO - Running setup.py install for mozdevice 07:37:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozfile 07:37:49 INFO - Running setup.py install for mozhttpd 07:37:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozinfo 07:37:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozInstall 07:37:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozleak 07:37:49 INFO - Running setup.py install for mozlog 07:37:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for moznetwork 07:37:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozprocess 07:37:49 INFO - Running setup.py install for mozprofile 07:37:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozrunner 07:37:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for mozscreenshot 07:37:50 INFO - Running setup.py install for moztest 07:37:50 INFO - Running setup.py install for mozversion 07:37:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:50 INFO - Cleaning up... 07:37:50 INFO - Return code: 0 07:37:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:50 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')]} 07:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:50 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')]} 07:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:50 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 0x7fd1579fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', '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 07:37:50 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 07:37:50 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 07:37:50 INFO - Using env: {'DISPLAY': ':0', 07:37:50 INFO - 'HOME': '/home/cltbld', 07:37:50 INFO - 'LANG': 'en_US.UTF-8', 07:37:50 INFO - 'LANGUAGE': 'en_US:en', 07:37:50 INFO - 'LOGNAME': 'cltbld', 07:37:50 INFO - 'MAIL': '/var/mail/cltbld', 07:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:50 INFO - 'MOZ_NO_REMOTE': '1', 07:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:50 INFO - 'NO_EM_RESTART': '1', 07:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:50 INFO - 'PWD': '/builds/slave/test', 07:37:50 INFO - 'SHELL': '/bin/bash', 07:37:50 INFO - 'SHLVL': '1', 07:37:50 INFO - 'TERM': 'linux', 07:37:50 INFO - 'TMOUT': '86400', 07:37:50 INFO - 'USER': 'cltbld', 07:37:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:50 INFO - '_': '/tools/buildbot/bin/python'} 07:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:50 INFO - Running setup.py (path:/tmp/pip-R0WRgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:50 INFO - Running setup.py (path:/tmp/pip-JFC7pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:50 INFO - Running setup.py (path:/tmp/pip-BI4xyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:50 INFO - Running setup.py (path:/tmp/pip-Dq1385-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:50 INFO - Running setup.py (path:/tmp/pip-xs5Lwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:51 INFO - Running setup.py (path:/tmp/pip-wOoSiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:51 INFO - Running setup.py (path:/tmp/pip-_ts0Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:51 INFO - Running setup.py (path:/tmp/pip-hCzLxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:51 INFO - Running setup.py (path:/tmp/pip-6WfGT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:51 INFO - Running setup.py (path:/tmp/pip-0RjDPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:51 INFO - Running setup.py (path:/tmp/pip-_RvLIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:51 INFO - Running setup.py (path:/tmp/pip-nBFmuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:51 INFO - Running setup.py (path:/tmp/pip-LmUoNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:51 INFO - Running setup.py (path:/tmp/pip-D2gBZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:51 INFO - Running setup.py (path:/tmp/pip-TNwi01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:51 INFO - Running setup.py (path:/tmp/pip-6mnt9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:51 INFO - Running setup.py (path:/tmp/pip-ieUyw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:51 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)) 07:37:51 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)) 07:37:51 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)) 07:37:51 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)) 07:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:53 INFO - Downloading blessings-1.6.tar.gz 07:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:53 INFO - Installing collected packages: blessings 07:37:53 INFO - Running setup.py install for blessings 07:37:54 INFO - Successfully installed blessings 07:37:54 INFO - Cleaning up... 07:37:54 INFO - Return code: 0 07:37:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:54 INFO - Reading from file tmpfile_stdout 07:37:54 INFO - Current package versions: 07:37:54 INFO - argparse == 1.2.1 07:37:54 INFO - blessings == 1.6 07:37:54 INFO - blobuploader == 1.2.4 07:37:54 INFO - docopt == 0.6.1 07:37:54 INFO - functools32 == 3.2.3-2 07:37:54 INFO - jsonschema == 2.5.1 07:37:54 INFO - manifestparser == 1.1 07:37:54 INFO - mozInstall == 1.12 07:37:54 INFO - mozcrash == 1.0 07:37:54 INFO - mozdebug == 0.1 07:37:54 INFO - mozdevice == 0.48 07:37:54 INFO - mozfile == 1.2 07:37:54 INFO - mozhttpd == 0.7 07:37:54 INFO - mozinfo == 0.9 07:37:54 INFO - mozleak == 0.1 07:37:54 INFO - mozlog == 3.4 07:37:54 INFO - moznetwork == 0.27 07:37:54 INFO - mozprocess == 0.23 07:37:54 INFO - mozprofile == 0.28 07:37:54 INFO - mozrunner == 6.13 07:37:54 INFO - mozscreenshot == 0.1 07:37:54 INFO - mozsystemmonitor == 0.3 07:37:54 INFO - moztest == 0.7 07:37:54 INFO - mozversion == 1.4 07:37:54 INFO - psutil == 3.1.1 07:37:54 INFO - requests == 1.2.3 07:37:54 INFO - wsgiref == 0.1.2 07:37:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:54 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 0x7fd1579fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', '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 07:37:54 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 07:37:54 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 07:37:54 INFO - Using env: {'DISPLAY': ':0', 07:37:54 INFO - 'HOME': '/home/cltbld', 07:37:54 INFO - 'LANG': 'en_US.UTF-8', 07:37:54 INFO - 'LANGUAGE': 'en_US:en', 07:37:54 INFO - 'LOGNAME': 'cltbld', 07:37:54 INFO - 'MAIL': '/var/mail/cltbld', 07:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:54 INFO - 'MOZ_NO_REMOTE': '1', 07:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:54 INFO - 'NO_EM_RESTART': '1', 07:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:54 INFO - 'PWD': '/builds/slave/test', 07:37:54 INFO - 'SHELL': '/bin/bash', 07:37:54 INFO - 'SHLVL': '1', 07:37:54 INFO - 'TERM': 'linux', 07:37:54 INFO - 'TMOUT': '86400', 07:37:54 INFO - 'USER': 'cltbld', 07:37:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:54 INFO - '_': '/tools/buildbot/bin/python'} 07:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 INFO - Cleaning up... 07:37:54 INFO - Return code: 0 07:37:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:54 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 0x7fd1579fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', '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 07:37:54 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 07:37:54 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 07:37:54 INFO - Using env: {'DISPLAY': ':0', 07:37:54 INFO - 'HOME': '/home/cltbld', 07:37:54 INFO - 'LANG': 'en_US.UTF-8', 07:37:54 INFO - 'LANGUAGE': 'en_US:en', 07:37:54 INFO - 'LOGNAME': 'cltbld', 07:37:54 INFO - 'MAIL': '/var/mail/cltbld', 07:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:54 INFO - 'MOZ_NO_REMOTE': '1', 07:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:54 INFO - 'NO_EM_RESTART': '1', 07:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:54 INFO - 'PWD': '/builds/slave/test', 07:37:54 INFO - 'SHELL': '/bin/bash', 07:37:54 INFO - 'SHLVL': '1', 07:37:54 INFO - 'TERM': 'linux', 07:37:54 INFO - 'TMOUT': '86400', 07:37:54 INFO - 'USER': 'cltbld', 07:37:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:54 INFO - '_': '/tools/buildbot/bin/python'} 07:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:37:54 INFO - Cleaning up... 07:37:54 INFO - Return code: 0 07:37:54 INFO - Running post-action listener: _resource_record_post_action 07:37:54 INFO - Running post-action listener: _start_resource_monitoring 07:37:54 INFO - Starting resource monitoring. 07:37:54 INFO - [mozharness: 2016-11-11 15:37:54.814484Z] Finished create-virtualenv step (success) 07:37:54 INFO - [mozharness: 2016-11-11 15:37:54.814993Z] Running install step. 07:37:54 INFO - Running pre-action listener: _resource_record_pre_action 07:37:54 INFO - Running main action method: install 07:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:55 INFO - Reading from file tmpfile_stdout 07:37:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:37:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:37:55 INFO - Reading from file tmpfile_stdout 07:37:55 INFO - Output received: 07:37:55 INFO - Usage: mozinstall [options] installer 07:37:55 INFO - Options: 07:37:55 INFO - -h, --help show this help message and exit 07:37:55 INFO - -d DEST, --destination=DEST 07:37:55 INFO - Directory to install application into. [default: 07:37:55 INFO - "/builds/slave/test"] 07:37:55 INFO - --app=APP Application being installed. [default: firefox] 07:37:55 INFO - mkdir: /builds/slave/test/build/application 07:37:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:38:11 INFO - Reading from file tmpfile_stdout 07:38:11 INFO - Output received: 07:38:11 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:11 INFO - Running post-action listener: _resource_record_post_action 07:38:11 INFO - [mozharness: 2016-11-11 15:38:11.152157Z] Finished install step (success) 07:38:11 INFO - [mozharness: 2016-11-11 15:38:11.152400Z] Running run-tests step. 07:38:11 INFO - Running pre-action listener: _resource_record_pre_action 07:38:11 INFO - Running main action method: run_tests 07:38:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:11 INFO - Python 2.7.3 07:38:11 INFO - Return code: 0 07:38:11 INFO - grabbing minidump binary from tooltool 07:38:11 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')]} 07:38:11 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 0x2247f60>, '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 0x2248d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22491d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:11 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 07:38:11 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 07:38:11 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 07:38:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:11 INFO - Return code: 0 07:38:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:11 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/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 07:38:11 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/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 07:38:11 INFO - Using env: {'DISPLAY': ':0', 07:38:11 INFO - 'HOME': '/home/cltbld', 07:38:11 INFO - 'LANG': 'en_US.UTF-8', 07:38:11 INFO - 'LANGUAGE': 'en_US:en', 07:38:11 INFO - 'LOGNAME': 'cltbld', 07:38:11 INFO - 'MAIL': '/var/mail/cltbld', 07:38:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:11 INFO - 'MOZ_NO_REMOTE': '1', 07:38:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:11 INFO - 'NO_EM_RESTART': '1', 07:38:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:11 INFO - 'PWD': '/builds/slave/test', 07:38:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:11 INFO - 'SHELL': '/bin/bash', 07:38:11 INFO - 'SHLVL': '1', 07:38:11 INFO - 'TERM': 'linux', 07:38:11 INFO - 'TMOUT': '86400', 07:38:11 INFO - 'USER': 'cltbld', 07:38:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345', 07:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:11 INFO - '_': '/tools/buildbot/bin/python'} 07:38:11 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/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 07:38:11 INFO - mozversion application_buildid: 20161111062119 07:38:11 INFO - mozversion application_changeset: bf3c647eec8100c19efd5ba415686bfd0854c113 07:38:11 INFO - mozversion application_display_name: Nightly 07:38:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:11 INFO - mozversion application_name: Firefox 07:38:11 INFO - mozversion application_remotingname: firefox 07:38:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:38:11 INFO - mozversion application_vendor: Mozilla 07:38:11 INFO - mozversion application_version: 52.0a1 07:38:11 INFO - mozversion platform_buildid: 20161111062119 07:38:11 INFO - mozversion platform_changeset: bf3c647eec8100c19efd5ba415686bfd0854c113 07:38:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:38:11 INFO - mozversion platform_version: 52.0a1 07:38:11 INFO - using testdate: 1478878691 07:38:11 INFO - actual date: 1478878691 07:38:11 INFO - starting webserver on 'localhost:51544' 07:38:11 INFO - SUITE-START | Running 2 tests 07:38:11 INFO - TEST-START | dromaeo_css 07:38:11 INFO - operating with platform_type : linux_ 07:38:11 INFO - Initialising browser for dromaeo_css test... 07:38:11 INFO - TEST-INFO | started process 20007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv3_dEp/profile http://localhost:51544/getInfo.html) 07:38:15 INFO - PROCESS | 20007 | __metrics Screen width/height:1600/1200 07:38:15 INFO - PROCESS | 20007 | colorDepth:24 07:38:15 INFO - PROCESS | 20007 | Browser inner width/height: 1024/697 07:38:15 INFO - PROCESS | 20007 | __metrics 07:38:16 INFO - PROCESS | 20007 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:16 INFO - PROCESS | 20007 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:16 INFO - PROCESS | 20007 | console.error: PushService: 07:38:16 INFO - PROCESS | 20007 | stateChangeProcessEnqueue: Error transitioning state 07:38:16 INFO - PROCESS | 20007 | UnknownError 07:38:17 INFO - TEST-INFO | 20007: exit 0 07:38:17 INFO - Browser initialized. 07:38:17 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:17 INFO - TEST-INFO | started process 20089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv3_dEp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:29 INFO - PROCESS | 20089 | RSS: Main: 174600192 07:38:29 INFO - PROCESS | 20089 | 07:39:21 INFO - PROCESS | 20089 | 1478878761482 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] 07:41:35 INFO - PROCESS | 20089 | Cycle 1(1): loaded http://localhost:51544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51544/tests/dromaeo/cssquery-ext.html) 07:41:36 INFO - PROCESS | 20089 | RSS: Main: 305836032 07:41:36 INFO - PROCESS | 20089 | 07:44:39 INFO - PROCESS | 20089 | Cycle 1(1): loaded http://localhost:51544/tests/dromaeo/cssquery-ext.html (next: http://localhost:51544/tests/dromaeo/cssquery-jquery.html) 07:44:39 INFO - PROCESS | 20089 | RSS: Main: 281174016 07:44:39 INFO - PROCESS | 20089 | 07:47:42 INFO - PROCESS | 20089 | Cycle 1(1): loaded http://localhost:51544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51544/tests/dromaeo/cssquery-mootools.html) 07:47:42 INFO - PROCESS | 20089 | RSS: Main: 258240512 07:47:42 INFO - PROCESS | 20089 | 07:50:44 INFO - PROCESS | 20089 | Cycle 1(1): loaded http://localhost:51544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51544/tests/dromaeo/cssquery-prototype.html) 07:50:45 INFO - PROCESS | 20089 | RSS: Main: 219959296 07:50:45 INFO - PROCESS | 20089 | 07:53:48 INFO - PROCESS | 20089 | Cycle 1(1): loaded http://localhost:51544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51544/tests/dromaeo/cssquery-yui.html) 07:53:49 INFO - PROCESS | 20089 | RSS: Main: 220569600 07:53:49 INFO - PROCESS | 20089 | 07:56:52 INFO - PROCESS | 20089 | Cycle 1(1): loaded http://localhost:51544/tests/dromaeo/cssquery-yui.html (next: http://localhost:51544/tests/dromaeo/cssquery-dojo.html) 07:56:52 INFO - PROCESS | 20089 | RSS: Main: 315154432 07:56:52 INFO - PROCESS | 20089 | 07:56:52 INFO - PROCESS | 20089 | __start_tp_report 07:56:52 INFO - PROCESS | 20089 | _x_x_mozilla_page_load 07:56:52 INFO - PROCESS | 20089 | _x_x_mozilla_page_load_details 07:56:52 INFO - PROCESS | 20089 | |i|pagename|runs| 07:56:52 INFO - PROCESS | 20089 | |0;dojo.html;2554.6168074788784;2565.050931155473;2592.4944635796014;2600.648912396826;2604.518164139633;4495.898504866308;4505.752183629895;4569.360289559464;4576.222042252817;4616.884577885555;4637.188492013901;4641.280601506772;4703;4717.716936983783;4786.353842231298;4240.681948853833;4270.466191726035;4293.03406733484;4346.804393802278;4376.89057773555;4285.485741710999;4320.697551171419;4347.347897815322;4361.869143925687;4392.560743925614;4419.359192917025;4427.933580996288;4433.490148632916;4451.5103338632725;4471.351654010183;4266.338717498793;4300.956990430087;4312.956870431287;4318.157959197958;4362.36745671879;4321.2005778931;4326.480822301344;4328.610425061728;4336.544662810423;4337.414449049369;4662.160811054009;4678.485366609671;4690.390249267608;4694.2958556216845;4695.1548721230165;4958.801647934079;4997.6501644884875;5009.599232061426;5029.874253143664;5030.798768049273;5041.747912604355;5047.394312682465;5050.646454748169;5055.974720126376;5062.063518249136;4619.422572178478;4643.3731446255;4643.88390290242;4643.953560464352;4644.442666879929;5019.84940451787;5054.014467178865;5062.493750624982;5062.848114556569;5079.492050794891;4912.410510738734;4923.310736496894;4923.679960802537;4930.728809915489;4971.651984361132;4855.902881942341;4909.680870743462;5016.749162541858;5025.14572522672;5074.797008119634;4906.411230652345;4909.582685471703;4911.312416261726;4914.877128071756;4915.016996600694;4855.587275081587;4887.193613053806;4887.902241955141;4932.161532539477;4943.629227807929;4102.876913692594;4113.876583702434;4154.813033413504;4155.439015732898;4157.376393540932;3651.2697460507475;3657.213699054663;3707.295613833417;3737.364648009845;3742.4573436851506;4269.316909294498;4311.568843115726;4324.459442569679;4334.241507736134;4365.519792822851;5033.421156566968;5033.924491132636;5036.64743467961;5039.823606173766;5078.4413714491375;4334.1981733379425;4354.521002689701;4369.912601748011;4372.650187984954;4412.536683648171;4365.126974605092;4413.3159360299205;4415.536368681306;4418.359337895987;4422.3366495026;4640.257558790578;4662.417197850269;4668.299755036772;4694.389729335165;4702.106599746037;4949.133901567139;4951.232558953368;4951.876203094951;4964.826231081895;5000.549950504472;4573.5426457354;4633.490316065163;4633.791479383503;4634.768261586974;4637.25803871379;4907.4847141051105;4925.852224433273;4942.233953737176;4954.777035033504;4985.725785081855;4983.352164218629;4990.451050384528;4997;5010.423801262901;5040.344755181803;4756.096341695067;4798.95201047985;4858.732769697701;4867.70793752376;4910.459849416633;4864.148773964472;4903.77932993009;4920.72935988524;4930.827421040246;4983.302337672656;4842.7820748065715;4859.198232291632;4862.610991120631;4874.293227482066;4916.336294600326;4786.540105267926;4939.456659767351;4958.132326842716;4971.279164521196;4976.203807390945;4776.402949631296;4800.543948324904;4833.758312084452;4859;4916.70499770015 07:56:52 INFO - PROCESS | 20089 | |1;ext.html;536.7611412921252;539.4039586257186;542.3681411156003;551.5549260936348;565.3413772954506;27268.45463090737;29767.55348669769;41608.58391416089;43076.569234307644;43171.35242971358;39391.60608393915;40090.198196036064;40249.195016099664;40440.19119617613;40466;7339.633018349101;7523.984262124598;7524.322810947014;7525.435592330569;7525.887111693329;7406.62966851658;7483.73806916758;7484.513506622079;7484.625768711569;7488.962555187244;7463.776086717407;7515.624218789066;7516.962415187916;7519.962400187991;7523.285287897668;7396.519226250277;7403.333699966975;7444.069491313586;7481.812954676122;7487.625618719069;7389.7413590524075;7461.552306861551;7467.02928619276;7468.701251949916;7469.589172595505;35936.46095308573;36130.819345903365;36199.81900090509;36265.45601815975;36317.63682363169;2890.2340879666904;3023.682513336112;3111.3310638212665;3143.9842800786078;3215.742740580771;26456.603150952753;26731.218034659196;27110.50892200928;27504.03735869235;27624.171274861787;3357.6642335766473;3469.3234819210265;3498.5276987606603;3550.8579656813695;3598;228691;228866;229462;230736;231029;49174.262386064234;49397;49482.505174947786;49491.50508494941;49497.75251123722;31103.377932441224;53016.20475692867;53095.03574463861;53095.46904530982;53180.468195318324;13958.511452099128;14821.77767333491;14865.331060102322;14905.105693658415;14964.625884352978;10393.740156496147;10429.21780866438;10444.68665940023;10463.94768026155;10467.267291289689;16974.57563560921;17013.574660633334;17044.829551704323;17045.829541704672;17374.826251737573;6604.240512341143;6654.567453115532;6697.531172817856;6727.899081513683;6803.455723542104;747.9065116860393;838.1409055717938;854.5940678177816;919.5494207838245;936.6487567162314;24650.630240546405;26925;26977.460450790873;27051.594226086625;27281.45437091247;732.7874916274221;766.8197973476229;868.891388576428;934.6168071090956;973.245734555725;12512.74974500523;13833.308334583231;14093.506727264497;14190.929045354913;14323.713525729427;342205;448102;453940;453979;455081;49197;49859;49883.501164988615;49961.00623900231;50064.24903626448;1036.5542816588788;1111.7832022755647;1112.844201811747;1187.6080893305189;1213.8968187704145;22423.887880560495;26999.730002700508;28984.855075724485;30763;31225.37549249048;46310.768446157555;47113.293300599835;47228.52771472241;47425.99999999862;47472.28791568198;249242;249493;251616;252535;252981;24349.87825060934;24506.75493245116;24787.504249915262;24928.875355623106;24955.63098981687;39608.40587391249;40524.79737601293;40841.38737918993;41031.38452923149;41176.38235426531;34308.31383372368;34431;34516.82741586276;34977.825110874284;35365.82317088398;34258.65741342655;34454.31091378108;34707;34752.65247347494;34839.825800870836;33866.49200262047;34238.14404639904;34624.653753462146;35057.8247108773;35104.82447587746;29160;31348.843255783577;31781.36437271288;32032.83983580067;32086.51870221902;24031;24299.757002430455;24627.63058554159;24792;24802.25593232134 07:56:52 INFO - PROCESS | 20089 | |2;jquery.html;317.8124906305279;321.9871205151794;327.43517432429064;335.5570646746295;341.53039570590437;12181.269123852564;13256.270905100215;13567.253801040939;13572.457101715945;15128.319225634832;14922.328495217715;15860.920695396508;16252.349906003745;16408.917955410205;16574.75137872933;4682.882927926804;4697.295405689139;4918.975405122969;4924.359833221676;4926.704397736147;4796.448408433022;4919.335889654904;4927.260910863363;4933.950660493403;4934.851954441355;5011.824586139486;5297.337832770903;5308.362996440433;5337.172738225562;5365.141577347626;5090.083784918713;5252.133397989327;5284.4187139414635;5286.788528458857;5287.101192797214;5123.436421993578;5155.690658560461;5160.071187186305;5164.431912489623;5168.2764412982215;11191.104711623051;11477.655670329903;11555.711107222303;18059.729104063448;18997.955112468808;1733.0554847607957;1790.498660375097;1851.7129844873932;1918.6162767446426;2022.1810166882435;8591.785205369853;8865.379423440361;8867.600957956907;9156.130167634064;9166.358354915159;1649.9010059396476;1735.5921358480748;1752.5881417866792;1761.7445470406847;1768.089433941521;62386.37613623851;66587.66706166486;66902.66548667225;68077;69465.30534694639;8824.911750882537;8832.293416526663;8903.73288801337;9041.819163616823;9189.862152067724;12054.276743395249;12107.697307567205;12109.878901211052;12117.21238119537;12134.57528986499;6863.210730766026;7037.437005039585;7079.610621415872;7168.964155179295;7237.819054523574;6813.693383797642;6859.279775623588;6889.793306200822;7047.89428158578;7056.611886346198;3792.867249646249;3858.357025437584;3911.47195128654;3944.3294639911283;4111.835526578963;1568.6078480379906;1739.6085880676999;1813.7642106526066;1826.7351234070986;1870.2892900697648;723.6960476599841;861.2033868671454;877.7542288159326;892.848215803315;912.4890061565544;15879.444219452263;16184.838151618333;16729.749053764204;16948.23732932021;17217.225224864662;834.3325339728193;834.845553572591;846.9745907622781;849.6389034660244;854.03920589337;9064.229540489132;9183.724488265363;9235.861462078074;9702.223822094216;10233.641822536176;390361;394642;403475;404871;407094;77221.61389193017;79759.60120199362;79772.60113699394;80450.59774701206;84316;879.6217626420572;925.9074092590687;937.3672770879629;964.7732782796037;965.5027660754716;10997.780044399227;14253.857461425669;14643.780343294646;15203.467878624195;15733.921330393276;36340.81829590835;36404.453933190496;36741;36931;37650;46455;48201.60068786553;48225.5177448221;49247.26129108138;49884.25173622471;6350.650714210763;7172.39034682037;7283.235260297804;7348.338649521569;8022.157673444204;11489.655310340702;11686.357250351311;11903.880961190624;11923.76152476963;12086.648895583268;10546;10551.683449496528;10558.419286939292;10644.095251903675;11153.721156970816;10467.895321046692;10647.520861561403;10795.40625265618;10803.189760767817;10897.564097436014;10614.840777388192;10646.946765266124;10661.57353705874;10826.67519974402;11188.216824822184;6584.473242140713;6835.93164068353;6972.6862291196;7183.066201393785;7256.238094999949;8943.463392196229;10566.577336906437;10582.576696932036;10720.303180293256;10750.677479675622 07:56:52 INFO - PROCESS | 20089 | |3;mootools.html;1309.4434865182297;1348.9258090805006;1391.7564426225408;1576.90538567686;1621.505440840543;6687.264400915901;7114.110736157973;7117.359437650611;7118.3949364304035;7122.8575428491395;6016.639001659903;6222.937770622292;6662.367075127855;6908.7236510539515;6913.343232392927;2000.7899170587061;2025.9797402025938;2034.0846619021424;2035.3181684135832;2036.5621391400846;2000.5598768270956;2002.78970708075;2030.2285131649953;2040.1125510402949;2042.9897850510727;1740.9651806963852;1810.8008119106887;1960.1179469238828;2024.6456870047757;2027.7668068172202;1999.8800071995654;2014.6776515757408;2020.686793546988;2022.4741567192636;2023.4334386371693;2015.4558269267216;2043.52998810273;2046.8976551172382;2050.4053824390908;2052.938411847647;6997.160340759091;7178.246284140195;7183.89224161638;7192.748253811092;7193.388561972239;4191.203671302474;4347.586979236968;4347.978260108679;4348.543402942677;4350.825966961318;2553.553128202557;2763.9723602763916;2787.1499192746205;2811.409603983166;2826.802123851331;833.3291700181352;858.1590041759049;865.9004214515348;885.5173930207987;891.2869704236649;9330.906690933072;9355.204807591432;9372.062793720641;9382.155605995426;9387.249020078378;3602.837872295753;3784.2242340320167;3788.2991646544924;3876.089119057019;3876.2441323942126;7615.847683046308;7623.199564045695;7627.970224019687;7634.045744281965;7638.236176382428;4203.726757760735;4222.514410842792;4224.556421575752;4226.1758957003085;4226.4716910386205;3701.833417496219;3864.091938394475;3865.594112618191;3869.3035253654048;3869.787161706077;3269.2317305433203;3293.3413317336626;3349.8995030149135;3379.7972121672287;3386.3227354529195;1058.6823952814125;1068.4123731947552;1084.983725244122;1095.5124969388546;1116.3692513729716;629.3423372575578;657.6645910585636;712.7327252280395;820.9671613135407;835.532102022857;4775.856724298207;4933.531314525115;4960.156773348539;4973.2540118981715;5048.495150484922;825.2490233887133;834.7161964931952;877.1886005444937;878.9208971192495;889.0709208876739;3355.7650964432255;3439.793612383265;3453.2575496268423;3468.341015207153;3559.5906470755676;8246.83506329882;8648.221660050625;8664.740057798275;8677.435966662148;8678.349123815738;8617.95691021541;8619.655213791379;8627.78430539229;8629.913700862911;8638.524881131598;6490;6551.312112228243;6567.1462709848365;6689.46484281266;6690.2306234782645;4775.5224477551965;4787.521247875324;4817.494163112963;4854.781534831011;4898.118338698926;7594.582297973665;7749.7287594933905;7755.7673269802;7833.020872390951;7863.764087077397;7845.450818442654;7860.449768516149;7923.920760792318;7957.482763620346;7997.400194985283;5787.131930210502;5805.651660900359;5832.241808565029;5868.471837534642;5928.8814223716145;6492.285848556749;6522.836929076621;6534.346565343428;6540.313267106885;6541;6120.112583675431;6220.346863579259;6300.369963003846;6402.519811014286;6419.261784894797;6142.416470435302;6142.938570614416;6160.507159427325;6184.134221209124;6234.376562343729;5608.6073974821375;5739.426057394227;5748.281464816898;5748.942510575008;5750.913736293875;4335.132973405394;4350.978245108754;4369.563043695732;4492.2587773017085;4507.09858028389;4302.612764851178;4343.587359200871;4360.280553708602;4403.691741578059;4419.756913369795 07:56:52 INFO - PROCESS | 20089 | |4;prototype.html;268.8776606643977;274.17473405050794;274.90240964457615;286.6116412261387;287.15433049668724;4565.863024109273;4701.341812146298;4724.3858298421155;4734.7159170449795;4749.311349854269;4558.769132334268;4675.579197872191;4679.15775160471;4695.272232803913;4702.800785799616;3458.7029863801076;3577.749557530974;3680.11677197472;3690.6678398944223;3702.722560716555;3599.4960705501253;3693.9445908311395;3696.611855755147;3702.4446333049987;3708.462272970418;3664.5602527696715;3683.189698266377;3684.281565094808;3685.7419980601367;3696.445533170019;3692.7230457715646;3699.648533389324;3714.53568303962;3727.496787933635;3730.253949210142;3151.5745374374396;3163.557102005721;3179.888703895376;3199.4720871056247;3304.487804390323;4559.133764584718;4560.475545312298;4561.361409402653;4563.931541026887;4588.862334129982;3932;4124.628783409477;4130.607592278729;4133.235351459959;4136.366135376509;4830.227163653799;4854.320395144682;4891.510848915115;4898.461169271377;4917.8278760243575;3416.777909435879;3416.8120753358558;3417.3165366926464;3445.2592692570965;3472.8437220325145;5140.151874940593;5147.124988751922;5156.587473002189;5160.612954028463;5172.6379153459275;3397.21863971288;3441.500982357544;3486.065233795268;3491.5810102787827;3502.2120022994623;3506;3524.700400465938;3529;3529.594096678915;3555.1467647764352;4027.154297597537;4077.836886524565;4081.4898137732785;4111.7944102794745;4117.814698338582;4671.416072990876;4727.220008698595;4857.878553036132;4889.555222388805;4915.926261106087;1163.8777928317575;1172.8271728271727;1177.5643012085584;1179.8289248058984;1182.4974385885964;792.3372522162672;815.0789607743212;823.7981694484889;827.8947604947463;830.33158307563;4257.446531950888;4264.744115353026;4267.679924005712;4287.935680964788;4312.805923733439;4913.631477639191;4931.3835770528685;4951.777170027357;4952.529509696573;4981.676191047571;4278.679099067583;4291.892702682396;4305.375720520507;4305.612494875476;4335.154644844225;2472.8134978554754;2578.23941937129;2591.5464793661035;2601.583746600535;2617.5395128579075;4573.954260457419;4574.794134263966;4599.586037256663;4607.424071991001;4610.97694511532;4990;4990.8752281193265;4995.375578052744;4995.850124496198;4999.375078115236;4359.520452750195;4504.869115964373;4546.272056913299;4561.543845615412;4603.9079218415445;4853.635977301646;4865.902681946271;4883.560479556715;4887.486813884633;4909.656324057424;4768.713877167381;4789.880252993703;4806.279058141306;4816.759162041954;4825.5174482551465;4446.244138496399;4552.567506086916;4553.977230113828;4561.863144105682;4572.497025327145;3375.594928608583;3387.525746395556;3397.371486275047;3397.677220664033;3421.6065152506785;4855.6115510758345;4911.287863259736;4959.677620954771;4964.801407943786;4995.5004499551205;4791.346985290069;4870.756462176948;4920.753962301942;4934.5312195341385;4953.975230123826;4919.237518184687;4921.557059864629;4928.905215283418;4931.457539670705;4931.827386041471;4750.619950404029;4862.781174847211;4872.43966943806;4880.169936273897;4890.6087512998165;4937.728424936663;4937.8889749806;4939.259111133359;4976.32819569368;4983.202687569971;4854.75726213695;4855.1988921828915;4863.659543831898;4865.885833066911;4866.7079975201605 07:56:52 INFO - PROCESS | 20089 | |5;yui.html;625.3402660193495;667.456023340977;686.6806934775328;707.3739740329809;715.4777012780673;11426.42867856607;12268.570600029001;12271.693207669812;12276.263424194554;12286.754264914718;10791.892081079186;10798.838017429745;10808.405537695424;10833.458327083654;10853.077488413493;594.2927915780218;613.4846728747851;737.8524295140967;756.4553521464537;766.4136935244543;766.3562607409775;768.1128296817158;768.5311959704603;768.6694721269852;769.8113962079299;820.4953953318695;821.4332110843499;821.4619424277079;822.01358369956;822.0505316359614;625.0592857749082;645.4578154350321;778.3695206882443;801.4750338528273;804.4007214625083;590.0411830774991;590.344717363726;590.35356284868;590.8729623131047;590.9231799866033;12024.218425802383;12048.819267710991;12060.396980150957;12065.577704780291;12066.155369124164;11664.35846028468;11666.766664666744;12081.818772718416;12083.697907552294;12258;10902.236843420964;10918.945405273002;11058.944705276423;11265.831012534736;11310;3956.188981258835;3958.5051868516434;3967.543732470774;4002.459667944819;4028.5165780106577;41939.161216775494;45041.54958450439;45046.09907801858;45174.77412612916;45481;9707.563159657691;10028.147607453448;10196.082352588302;10250;10380.480975951172;16253.431129910396;16917.577060573585;16969.83030169707;17736;17741.911290443724;6346.682665866688;6396.360363963567;6590.703418346186;6722.428593569503;6885.345892140239;3501.6848483636086;3542.8405721742583;3587.264610754789;3592.8203589820405;3632.20091579852;2663.1744159310288;2695.6899956504863;2718.388362618395;2720.7415295546894;2728.113363156982;469.63368572513497;469.694698446006;480.0518975024369;482.96377771667267;490.38701622971286;510.77525888609637;544.5425842292493;571.9761626688181;600.7687040489443;619.3651507205151;7339.70641174347;7349.30181632744;7497.1753107158165;7874.921250787534;7918.762437126896;504.7829433343624;530.3794560364383;577.9364269930304;609.2719200555382;615.8521954730833;3413.5221069050353;3443.7933723976644;3481.7562770606323;3527.700145487611;3627.147620309225;66920.6653966727;69694.3030569698;69898;73175.63412182905;73251.63374183202;60217;60758.39241607527;60852.69573652192;61153;63651;55505.72247138739;56037.159442607575;56388;56498.43501565014;56559;6717.697703603252;6737.865242695217;6865.519413640997;7117.3238542338395;7171.247019063132;38058;39519.80240098781;39816.800915995234;39933.80033099816;40747.796261018506;48138.5186148134;48948.75525622349;51525.7423712879;53278.46721532735;53304;9657.517124143906;9834.459104749307;10005.699829005142;10087.646932357333;10222.437765922945;11349.773004540028;11678;11718.765624687288;11739.23694959825;11908.40457977115;11411.201215914807;11577.421128943352;11688.649340519798;11702.590409335633;12244.326562039174;10848.728781780519;11290;11359.318440893572;11630.418479075843;11684.415779211175;10468.371897686164;11216.66350009501;11500.597479088192;11778.823317650413;11791.469383877575;9274.304427168125;10009.749756256151;10018.998100189923;10029.598816047568;10423.42671153094;8895.421797583136;9185.954070229605;9702.9029709702;9745.269104817025;9808.705738827846 07:56:52 INFO - PROCESS | 20089 | __end_tp_report 07:56:52 INFO - PROCESS | 20089 | __start_cc_report 07:56:52 INFO - PROCESS | 20089 | _x_x_mozilla_cycle_collect,1286 07:56:52 INFO - PROCESS | 20089 | __end_cc_report 07:56:52 INFO - PROCESS | 20089 | __startTimestamp1478879812831__endTimestamp 07:56:52 INFO - PROCESS | 20089 | 07:56:52 INFO - PROCESS | 20089 | ------- Summary: start ------- 07:56:52 INFO - PROCESS | 20089 | Number of tests: 6 07:56:52 INFO - PROCESS | 20089 | 07:56:52 INFO - PROCESS | 20089 | [#0] dojo.html Cycles:165 Average:4615.11 Median:4703.00 stddev:483.77 (10.3%) stddev-sans-first:457.46 07:56:52 INFO - PROCESS | 20089 | Values: 2554.6 2565.1 2592.5 2600.6 2604.5 4495.9 4505.8 4569.4 4576.2 4616.9 4637.2 4641.3 4703.0 4717.7 4786.4 4240.7 4270.5 4293.0 4346.8 4376.9 4285.5 4320.7 4347.3 4361.9 4392.6 4419.4 4427.9 4433.5 4451.5 4471.4 4266.3 4301.0 4313.0 4318.2 4362.4 4321.2 4326.5 4328.6 4336.5 4337.4 4662.2 4678.5 4690.4 4694.3 4695.2 4958.8 4997.7 5009.6 5029.9 5030.8 5041.7 5047.4 5050.6 5056.0 5062.1 4619.4 4643.4 4643.9 4644.0 4644.4 5019.8 5054.0 5062.5 5062.8 5079.5 4912.4 4923.3 4923.7 4930.7 4971.7 4855.9 4909.7 5016.7 5025.1 5074.8 4906.4 4909.6 4911.3 4914.9 4915.0 4855.6 4887.2 4887.9 4932.2 4943.6 4102.9 4113.9 4154.8 4155.4 4157.4 3651.3 3657.2 3707.3 3737.4 3742.5 4269.3 4311.6 4324.5 4334.2 4365.5 5033.4 5033.9 5036.6 5039.8 5078.4 4334.2 4354.5 4369.9 4372.7 4412.5 4365.1 4413.3 4415.5 4418.4 4422.3 4640.3 4662.4 4668.3 4694.4 4702.1 4949.1 4951.2 4951.9 4964.8 5000.5 4573.5 4633.5 4633.8 4634.8 4637.3 4907.5 4925.9 4942.2 4954.8 4985.7 4983.4 4990.5 4997.0 5010.4 5040.3 4756.1 4799.0 4858.7 4867.7 4910.5 4864.1 4903.8 4920.7 4930.8 4983.3 4842.8 4859.2 4862.6 4874.3 4916.3 4786.5 4939.5 4958.1 4971.3 4976.2 4776.4 4800.5 4833.8 4859.0 4916.7 07:56:52 INFO - PROCESS | 20089 | 07:56:52 INFO - PROCESS | 20089 | [#1] ext.html Cycles:180 Average:45463.95 Median:35235.32 stddev:84175.59 (238.9%) stddev-sans-first:84344.13 07:56:52 INFO - PROCESS | 20089 | Values: 536.8 539.4 542.4 551.6 565.3 27268.5 29767.6 41608.6 43076.6 43171.4 39391.6 40090.2 40249.2 40440.2 40466.0 7339.6 7524.0 7524.3 7525.4 7525.9 7406.6 7483.7 7484.5 7484.6 7489.0 7463.8 7515.6 7517.0 7520.0 7523.3 7396.5 7403.3 7444.1 7481.8 7487.6 7389.7 7461.6 7467.0 7468.7 7469.6 35936.5 36130.8 36199.8 36265.5 36317.6 2890.2 3023.7 3111.3 3144.0 3215.7 26456.6 26731.2 27110.5 27504.0 27624.2 3357.7 3469.3 3498.5 3550.9 3598.0 228691.0 228866.0 229462.0 230736.0 231029.0 49174.3 49397.0 49482.5 49491.5 49497.8 31103.4 53016.2 53095.0 53095.5 53180.5 13958.5 14821.8 14865.3 14905.1 14964.6 10393.7 10429.2 10444.7 10463.9 10467.3 16974.6 17013.6 17044.8 17045.8 17374.8 6604.2 6654.6 6697.5 6727.9 6803.5 747.9 838.1 854.6 919.5 936.6 24650.6 26925.0 26977.5 27051.6 27281.5 732.8 766.8 868.9 934.6 973.2 12512.7 13833.3 14093.5 14190.9 14323.7 342205.0 448102.0 453940.0 453979.0 455081.0 49197.0 49859.0 49883.5 49961.0 50064.2 1036.6 1111.8 1112.8 1187.6 1213.9 22423.9 26999.7 28984.9 30763.0 31225.4 46310.8 47113.3 47228.5 47426.0 47472.3 249242.0 249493.0 251616.0 252535.0 252981.0 24349.9 24506.8 24787.5 24928.9 24955.6 39608.4 40524.8 40841.4 41031.4 41176.4 34308.3 34431.0 34516.8 34977.8 35365.8 34258.7 34454.3 34707.0 34752.7 34839.8 33866.5 34238.1 34624.7 35057.8 35104.8 29160.0 31348.8 31781.4 32032.8 32086.5 24031.0 24299.8 24627.6 24792.0 24802.3 07:56:52 INFO - PROCESS | 20089 | 07:56:52 INFO - PROCESS | 20089 | [#2] jquery.html Cycles:180 Average:24069.71 Median:25568.94 stddev:66084.00 (258.5%) stddev-sans-first:66245.32 07:56:52 INFO - PROCESS | 20089 | Values: 317.8 322.0 327.4 335.6 341.5 12181.3 13256.3 13567.3 13572.5 15128.3 14922.3 15860.9 16252.3 16408.9 16574.8 4682.9 4697.3 4919.0 4924.4 4926.7 4796.4 4919.3 4927.3 4934.0 4934.9 5011.8 5297.3 5308.4 5337.2 5365.1 5090.1 5252.1 5284.4 5286.8 5287.1 5123.4 5155.7 5160.1 5164.4 5168.3 11191.1 11477.7 11555.7 18059.7 18998.0 1733.1 1790.5 1851.7 1918.6 2022.2 8591.8 8865.4 8867.6 9156.1 9166.4 1649.9 1735.6 1752.6 1761.7 1768.1 62386.4 66587.7 66902.7 68077.0 69465.3 8824.9 8832.3 8903.7 9041.8 9189.9 12054.3 12107.7 12109.9 12117.2 12134.6 6863.2 7037.4 7079.6 7169.0 7237.8 6813.7 6859.3 6889.8 7047.9 7056.6 3792.9 3858.4 3911.5 3944.3 4111.8 1568.6 1739.6 1813.8 1826.7 1870.3 723.7 861.2 877.8 892.8 912.5 15879.4 16184.8 16729.7 16948.2 17217.2 834.3 834.8 847.0 849.6 854.0 9064.2 9183.7 9235.9 9702.2 10233.6 390361.0 394642.0 403475.0 404871.0 407094.0 77221.6 79759.6 79772.6 80450.6 84316.0 879.6 925.9 937.4 964.8 965.5 10997.8 14253.9 14643.8 15203.5 15733.9 36340.8 36404.5 36741.0 36931.0 37650.0 46455.0 48201.6 48225.5 49247.3 49884.3 6350.7 7172.4 7283.2 7348.3 8022.2 11489.7 11686.4 11903.9 11923.8 12086.6 10546.0 10551.7 10558.4 10644.1 11153.7 10467.9 10647.5 10795.4 10803.2 10897.6 10614.8 10646.9 10661.6 10826.7 11188.2 6584.5 6835.9 6972.7 7183.1 7256.2 8943.5 10566.6 10582.6 10720.3 10750.7 07:56:52 INFO - PROCESS | 20089 | 07:56:52 INFO - PROCESS | 20089 | [#3] mootools.html Cycles:180 Average:4639.22 Median:5674.02 stddev:2502.41 (44.1%) stddev-sans-first:2496.92 07:56:52 INFO - PROCESS | 20089 | Values: 1309.4 1348.9 1391.8 1576.9 1621.5 6687.3 7114.1 7117.4 7118.4 7122.9 6016.6 6222.9 6662.4 6908.7 6913.3 2000.8 2026.0 2034.1 2035.3 2036.6 2000.6 2002.8 2030.2 2040.1 2043.0 1741.0 1810.8 1960.1 2024.6 2027.8 1999.9 2014.7 2020.7 2022.5 2023.4 2015.5 2043.5 2046.9 2050.4 2052.9 6997.2 7178.2 7183.9 7192.7 7193.4 4191.2 4347.6 4348.0 4348.5 4350.8 2553.6 2764.0 2787.1 2811.4 2826.8 833.3 858.2 865.9 885.5 891.3 9330.9 9355.2 9372.1 9382.2 9387.2 3602.8 3784.2 3788.3 3876.1 3876.2 7615.8 7623.2 7628.0 7634.0 7638.2 4203.7 4222.5 4224.6 4226.2 4226.5 3701.8 3864.1 3865.6 3869.3 3869.8 3269.2 3293.3 3349.9 3379.8 3386.3 1058.7 1068.4 1085.0 1095.5 1116.4 629.3 657.7 712.7 821.0 835.5 4775.9 4933.5 4960.2 4973.3 5048.5 825.2 834.7 877.2 878.9 889.1 3355.8 3439.8 3453.3 3468.3 3559.6 8246.8 8648.2 8664.7 8677.4 8678.3 8618.0 8619.7 8627.8 8629.9 8638.5 6490.0 6551.3 6567.1 6689.5 6690.2 4775.5 4787.5 4817.5 4854.8 4898.1 7594.6 7749.7 7755.8 7833.0 7863.8 7845.5 7860.4 7923.9 7957.5 7997.4 5787.1 5805.7 5832.2 5868.5 5928.9 6492.3 6522.8 6534.3 6540.3 6541.0 6120.1 6220.3 6300.4 6402.5 6419.3 6142.4 6142.9 6160.5 6184.1 6234.4 5608.6 5739.4 5748.3 5748.9 5750.9 4335.1 4351.0 4369.6 4492.3 4507.1 4302.6 4343.6 4360.3 4403.7 4419.8 07:56:52 INFO - PROCESS | 20089 | 07:56:52 INFO - PROCESS | 20089 | [#4] prototype.html Cycles:180 Average:4021.78 Median:4561.70 stddev:1177.31 (25.8%) stddev-sans-first:1146.42 07:56:52 INFO - PROCESS | 20089 | Values: 268.9 274.2 274.9 286.6 287.2 4565.9 4701.3 4724.4 4734.7 4749.3 4558.8 4675.6 4679.2 4695.3 4702.8 3458.7 3577.7 3680.1 3690.7 3702.7 3599.5 3693.9 3696.6 3702.4 3708.5 3664.6 3683.2 3684.3 3685.7 3696.4 3692.7 3699.6 3714.5 3727.5 3730.3 3151.6 3163.6 3179.9 3199.5 3304.5 4559.1 4560.5 4561.4 4563.9 4588.9 3932.0 4124.6 4130.6 4133.2 4136.4 4830.2 4854.3 4891.5 4898.5 4917.8 3416.8 3416.8 3417.3 3445.3 3472.8 5140.2 5147.1 5156.6 5160.6 5172.6 3397.2 3441.5 3486.1 3491.6 3502.2 3506.0 3524.7 3529.0 3529.6 3555.1 4027.2 4077.8 4081.5 4111.8 4117.8 4671.4 4727.2 4857.9 4889.6 4915.9 1163.9 1172.8 1177.6 1179.8 1182.5 792.3 815.1 823.8 827.9 830.3 4257.4 4264.7 4267.7 4287.9 4312.8 4913.6 4931.4 4951.8 4952.5 4981.7 4278.7 4291.9 4305.4 4305.6 4335.2 2472.8 2578.2 2591.5 2601.6 2617.5 4574.0 4574.8 4599.6 4607.4 4611.0 4990.0 4990.9 4995.4 4995.9 4999.4 4359.5 4504.9 4546.3 4561.5 4603.9 4853.6 4865.9 4883.6 4887.5 4909.7 4768.7 4789.9 4806.3 4816.8 4825.5 4446.2 4552.6 4554.0 4561.9 4572.5 3375.6 3387.5 3397.4 3397.7 3421.6 4855.6 4911.3 4959.7 4964.8 4995.5 4791.3 4870.8 4920.8 4934.5 4954.0 4919.2 4921.6 4928.9 4931.5 4931.8 4750.6 4862.8 4872.4 4880.2 4890.6 4937.7 4937.9 4939.3 4976.3 4983.2 4854.8 4855.2 4863.7 4865.9 4866.7 07:56:52 INFO - PROCESS | 20089 | 07:56:52 INFO - PROCESS | 20089 | [#5] yui.html Cycles:180 Average:14578.35 Median:22975.32 stddev:18697.51 (81.4%) stddev-sans-first:18720.60 07:56:52 INFO - PROCESS | 20089 | Values: 625.3 667.5 686.7 707.4 715.5 11426.4 12268.6 12271.7 12276.3 12286.8 10791.9 10798.8 10808.4 10833.5 10853.1 594.3 613.5 737.9 756.5 766.4 766.4 768.1 768.5 768.7 769.8 820.5 821.4 821.5 822.0 822.1 625.1 645.5 778.4 801.5 804.4 590.0 590.3 590.4 590.9 590.9 12024.2 12048.8 12060.4 12065.6 12066.2 11664.4 11666.8 12081.8 12083.7 12258.0 10902.2 10918.9 11058.9 11265.8 11310.0 3956.2 3958.5 3967.5 4002.5 4028.5 41939.2 45041.5 45046.1 45174.8 45481.0 9707.6 10028.1 10196.1 10250.0 10380.5 16253.4 16917.6 16969.8 17736.0 17741.9 6346.7 6396.4 6590.7 6722.4 6885.3 3501.7 3542.8 3587.3 3592.8 3632.2 2663.2 2695.7 2718.4 2720.7 2728.1 469.6 469.7 480.1 483.0 490.4 510.8 544.5 572.0 600.8 619.4 7339.7 7349.3 7497.2 7874.9 7918.8 504.8 530.4 577.9 609.3 615.9 3413.5 3443.8 3481.8 3527.7 3627.1 66920.7 69694.3 69898.0 73175.6 73251.6 60217.0 60758.4 60852.7 61153.0 63651.0 55505.7 56037.2 56388.0 56498.4 56559.0 6717.7 6737.9 6865.5 7117.3 7171.2 38058.0 39519.8 39816.8 39933.8 40747.8 48138.5 48948.8 51525.7 53278.5 53304.0 9657.5 9834.5 10005.7 10087.6 10222.4 11349.8 11678.0 11718.8 11739.2 11908.4 11411.2 11577.4 11688.6 11702.6 12244.3 10848.7 11290.0 11359.3 11630.4 11684.4 10468.4 11216.7 11500.6 11778.8 11791.5 9274.3 10009.7 10019.0 10029.6 10423.4 8895.4 9186.0 9702.9 9745.3 9808.7 07:56:52 INFO - PROCESS | 20089 | -------- Summary: end -------- 07:56:52 INFO - PROCESS | 20089 | 07:56:53 INFO - TEST-INFO | 20089: exit 0 07:56:53 INFO - TEST-OK | dromaeo_css | took 1122379ms 07:56:53 INFO - TEST-START | kraken 07:56:53 INFO - operating with platform_type : linux_ 07:56:53 INFO - Initialising browser for kraken test... 07:56:53 INFO - TEST-INFO | started process 20400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3iW0x6/profile http://localhost:51544/getInfo.html) 07:56:57 INFO - PROCESS | 20400 | __metrics Screen width/height:1600/1200 07:56:57 INFO - PROCESS | 20400 | colorDepth:24 07:56:57 INFO - PROCESS | 20400 | Browser inner width/height: 1024/697 07:56:57 INFO - PROCESS | 20400 | __metrics 07:56:58 INFO - PROCESS | 20400 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:56:58 INFO - PROCESS | 20400 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:59 INFO - PROCESS | 20400 | console.error: PushService: 07:56:59 INFO - PROCESS | 20400 | stateChangeProcessEnqueue: Error transitioning state 07:56:59 INFO - PROCESS | 20400 | UnknownError 07:56:59 INFO - TEST-INFO | 20400: exit 0 07:56:59 INFO - Browser initialized. 07:56:59 INFO - Running cycle 1/1 for kraken test... 07:56:59 INFO - TEST-INFO | started process 20482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3iW0x6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:12 INFO - PROCESS | 20482 | RSS: Main: 174321664 07:57:12 INFO - PROCESS | 20482 | 07:57:14 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51544/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:15 INFO - PROCESS | 20482 | RSS: Main: 230924288 07:57:15 INFO - PROCESS | 20482 | 07:57:18 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51544/tests/kraken/driver.html?testName=audio-dft) 07:57:19 INFO - PROCESS | 20482 | RSS: Main: 217874432 07:57:19 INFO - PROCESS | 20482 | 07:57:22 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51544/tests/kraken/driver.html?testName=audio-fft) 07:57:23 INFO - PROCESS | 20482 | RSS: Main: 298942464 07:57:23 INFO - PROCESS | 20482 | 07:57:25 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51544/tests/kraken/driver.html?testName=audio-oscillator) 07:57:25 INFO - PROCESS | 20482 | RSS: Main: 210067456 07:57:25 INFO - PROCESS | 20482 | 07:57:28 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:28 INFO - PROCESS | 20482 | RSS: Main: 213377024 07:57:28 INFO - PROCESS | 20482 | 07:57:31 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51544/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:32 INFO - PROCESS | 20482 | RSS: Main: 249384960 07:57:32 INFO - PROCESS | 20482 | 07:57:36 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51544/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:36 INFO - PROCESS | 20482 | RSS: Main: 248668160 07:57:36 INFO - PROCESS | 20482 | 07:57:39 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51544/tests/kraken/driver.html?testName=json-parse-financial) 07:57:40 INFO - PROCESS | 20482 | RSS: Main: 247820288 07:57:40 INFO - PROCESS | 20482 | 07:57:41 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:42 INFO - PROCESS | 20482 | RSS: Main: 210464768 07:57:42 INFO - PROCESS | 20482 | 07:57:44 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51544/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:44 INFO - PROCESS | 20482 | RSS: Main: 217509888 07:57:44 INFO - PROCESS | 20482 | 07:57:47 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:47 INFO - PROCESS | 20482 | RSS: Main: 226689024 07:57:47 INFO - PROCESS | 20482 | 07:57:50 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:51 INFO - PROCESS | 20482 | RSS: Main: 235544576 07:57:51 INFO - PROCESS | 20482 | 07:57:54 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:54 INFO - PROCESS | 20482 | RSS: Main: 231690240 07:57:54 INFO - PROCESS | 20482 | 07:57:56 INFO - PROCESS | 20482 | Cycle 1(1): loaded http://localhost:51544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51544/tests/kraken/driver.html?testName=ai-astar) 07:57:57 INFO - PROCESS | 20482 | RSS: Main: 282083328 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | __start_tp_report 07:57:57 INFO - PROCESS | 20482 | _x_x_mozilla_page_load 07:57:57 INFO - PROCESS | 20482 | _x_x_mozilla_page_load_details 07:57:57 INFO - PROCESS | 20482 | |i|pagename|runs| 07:57:57 INFO - PROCESS | 20482 | |0;ai-astar;108;118;116;118;115;117;115;116;116;115 07:57:57 INFO - PROCESS | 20482 | |1;audio-beat-detection;168;128;130;162;132;134;128;134;164;132 07:57:57 INFO - PROCESS | 20482 | |2;audio-dft;161;161;162;162;162;161;161;162;161;160 07:57:57 INFO - PROCESS | 20482 | |3;audio-fft;77;76;78;104;77;76;77;75;97;76 07:57:57 INFO - PROCESS | 20482 | |4;audio-oscillator;84;83;132;83;84;83;114;84;83;116 07:57:57 INFO - PROCESS | 20482 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;116;117 07:57:57 INFO - PROCESS | 20482 | |6;imaging-darkroom;146;147;146;147;146;147;146;147;146;147 07:57:57 INFO - PROCESS | 20482 | |7;imaging-desaturate;84;85;85;84;84;85;85;85;84;84 07:57:57 INFO - PROCESS | 20482 | |8;json-parse-financial;63;64;64;64;64;65;64;65;65;64 07:57:57 INFO - PROCESS | 20482 | |9;json-stringify-tinderbox;65;66;66;66;66;66;66;66;67;70 07:57:57 INFO - PROCESS | 20482 | |10;stanford-crypto-aes;89;90;83;84;84;84;84;84;85;84 07:57:57 INFO - PROCESS | 20482 | |11;stanford-crypto-ccm;146;146;150;144;143;152;145;138;205;145 07:57:57 INFO - PROCESS | 20482 | |12;stanford-crypto-pbkdf2;183;180;183;179;185;183;180;181;184;184 07:57:57 INFO - PROCESS | 20482 | |13;stanford-crypto-sha256-iterative;69;71;69;69;70;72;70;71;70;68 07:57:57 INFO - PROCESS | 20482 | __end_tp_report 07:57:57 INFO - PROCESS | 20482 | __start_cc_report 07:57:57 INFO - PROCESS | 20482 | _x_x_mozilla_cycle_collect,1947 07:57:57 INFO - PROCESS | 20482 | __end_cc_report 07:57:57 INFO - PROCESS | 20482 | __startTimestamp1478879877003__endTimestamp 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | ------- Summary: start ------- 07:57:57 INFO - PROCESS | 20482 | Number of tests: 14 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:2.84 (2.4%) stddev-sans-first:1.20 07:57:57 INFO - PROCESS | 20482 | Values: 108.0 118.0 116.0 118.0 115.0 117.0 115.0 116.0 116.0 115.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:134.00 stddev:16.39 (12.2%) stddev-sans-first:14.23 07:57:57 INFO - PROCESS | 20482 | Values: 168.0 128.0 130.0 162.0 132.0 134.0 128.0 134.0 164.0 132.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 07:57:57 INFO - PROCESS | 20482 | Values: 161.0 161.0 162.0 162.0 162.0 161.0 161.0 162.0 161.0 160.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#3] audio-fft Cycles:10 Average:81.30 Median:77.00 stddev:10.29 (13.4%) stddev-sans-first:10.79 07:57:57 INFO - PROCESS | 20482 | Values: 77.0 76.0 78.0 104.0 77.0 76.0 77.0 75.0 97.0 76.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:83.00 stddev:18.58 (22.4%) stddev-sans-first:19.31 07:57:57 INFO - PROCESS | 20482 | Values: 84.0 83.0 132.0 83.0 84.0 83.0 114.0 84.0 83.0 116.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:57:57 INFO - PROCESS | 20482 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:57:57 INFO - PROCESS | 20482 | Values: 146.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:57:57 INFO - PROCESS | 20482 | Values: 84.0 85.0 85.0 84.0 84.0 85.0 85.0 85.0 84.0 84.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 07:57:57 INFO - PROCESS | 20482 | Values: 63.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:1.35 (2.0%) stddev-sans-first:1.33 07:57:57 INFO - PROCESS | 20482 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 70.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:2.38 (2.8%) stddev-sans-first:2.06 07:57:57 INFO - PROCESS | 20482 | Values: 89.0 90.0 83.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:146.00 stddev:19.21 (13.2%) stddev-sans-first:20.27 07:57:57 INFO - PROCESS | 20482 | Values: 146.0 146.0 150.0 144.0 143.0 152.0 145.0 138.0 205.0 145.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:183.00 stddev:2.04 (1.1%) stddev-sans-first:2.15 07:57:57 INFO - PROCESS | 20482 | Values: 183.0 180.0 183.0 179.0 185.0 183.0 180.0 181.0 184.0 184.0 07:57:57 INFO - PROCESS | 20482 | 07:57:57 INFO - PROCESS | 20482 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.20 (1.7%) stddev-sans-first:1.22 07:57:57 INFO - PROCESS | 20482 | Values: 69.0 71.0 69.0 69.0 70.0 72.0 70.0 71.0 70.0 68.0 07:57:57 INFO - PROCESS | 20482 | -------- Summary: end -------- 07:57:57 INFO - PROCESS | 20482 | 07:57:58 INFO - TEST-INFO | 20482: exit 0 07:57:58 INFO - TEST-OK | kraken | took 64500ms 07:57:58 INFO - SUITE-END | took 1186s 07:57:58 INFO - Completed test suite (00:19:47) 07:57:58 INFO - javascript benchmark 07:57:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2554.6168074788784, 2565.050931155473, 2592.4944635796014, 2600.648912396826, 2604.518164139633, 4495.898504866308, 4505.752183629895, 4569.360289559464, 4576.222042252817, 4616.884577885555, 4637.188492013901, 4641.280601506772, 4703.0, 4717.716936983783, 4786.353842231298, 4240.681948853833, 4270.466191726035, 4293.03406733484, 4346.804393802278, 4376.89057773555, 4285.485741710999, 4320.697551171419, 4347.347897815322, 4361.869143925687, 4392.560743925614, 4419.359192917025, 4427.933580996288, 4433.490148632916, 4451.5103338632725, 4471.351654010183, 4266.338717498793, 4300.956990430087, 4312.956870431287, 4318.157959197958, 4362.36745671879, 4321.2005778931, 4326.480822301344, 4328.610425061728, 4336.544662810423, 4337.414449049369, 4662.160811054009, 4678.485366609671, 4690.390249267608, 4694.2958556216845, 4695.1548721230165, 4958.801647934079, 4997.6501644884875, 5009.599232061426, 5029.874253143664, 5030.798768049273, 5041.747912604355, 5047.394312682465, 5050.646454748169, 5055.974720126376, 5062.063518249136, 4619.422572178478, 4643.3731446255, 4643.88390290242, 4643.953560464352, 4644.442666879929, 5019.84940451787, 5054.014467178865, 5062.493750624982, 5062.848114556569, 5079.492050794891, 4912.410510738734, 4923.310736496894, 4923.679960802537, 4930.728809915489, 4971.651984361132, 4855.902881942341, 4909.680870743462, 5016.749162541858, 5025.14572522672, 5074.797008119634, 4906.411230652345, 4909.582685471703, 4911.312416261726, 4914.877128071756, 4915.016996600694, 4855.587275081587, 4887.193613053806, 4887.902241955141, 4932.161532539477, 4943.629227807929, 4102.876913692594, 4113.876583702434, 4154.813033413504, 4155.439015732898, 4157.376393540932, 3651.2697460507475, 3657.213699054663, 3707.295613833417, 3737.364648009845, 3742.4573436851506, 4269.316909294498, 4311.568843115726, 4324.459442569679, 4334.241507736134, 4365.519792822851, 5033.421156566968, 5033.924491132636, 5036.64743467961, 5039.823606173766, 5078.4413714491375, 4334.1981733379425, 4354.521002689701, 4369.912601748011, 4372.650187984954, 4412.536683648171, 4365.126974605092, 4413.3159360299205, 4415.536368681306, 4418.359337895987, 4422.3366495026, 4640.257558790578, 4662.417197850269, 4668.299755036772, 4694.389729335165, 4702.106599746037, 4949.133901567139, 4951.232558953368, 4951.876203094951, 4964.826231081895, 5000.549950504472, 4573.5426457354, 4633.490316065163, 4633.791479383503, 4634.768261586974, 4637.25803871379, 4907.4847141051105, 4925.852224433273, 4942.233953737176, 4954.777035033504, 4985.725785081855, 4983.352164218629, 4990.451050384528, 4997.0, 5010.423801262901, 5040.344755181803, 4756.096341695067, 4798.95201047985, 4858.732769697701, 4867.70793752376, 4910.459849416633, 4864.148773964472, 4903.77932993009, 4920.72935988524, 4930.827421040246, 4983.302337672656, 4842.7820748065715, 4859.198232291632, 4862.610991120631, 4874.293227482066, 4916.336294600326, 4786.540105267926, 4939.456659767351, 4958.132326842716, 4971.279164521196, 4976.203807390945, 4776.402949631296, 4800.543948324904, 4833.758312084452, 4859.0, 4916.70499770015], "value": 4583.865460306066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.7611412921252, 539.4039586257186, 542.3681411156003, 551.5549260936348, 565.3413772954506, 27268.45463090737, 29767.55348669769, 41608.58391416089, 43076.569234307644, 43171.35242971358, 39391.60608393915, 40090.198196036064, 40249.195016099664, 40440.19119617613, 40466.0, 7339.633018349101, 7523.984262124598, 7524.322810947014, 7525.435592330569, 7525.887111693329, 7406.62966851658, 7483.73806916758, 7484.513506622079, 7484.625768711569, 7488.962555187244, 7463.776086717407, 7515.624218789066, 7516.962415187916, 7519.962400187991, 7523.285287897668, 7396.519226250277, 7403.333699966975, 7444.069491313586, 7481.812954676122, 7487.625618719069, 7389.7413590524075, 7461.552306861551, 7467.02928619276, 7468.701251949916, 7469.589172595505, 35936.46095308573, 36130.819345903365, 36199.81900090509, 36265.45601815975, 36317.63682363169, 2890.2340879666904, 3023.682513336112, 3111.3310638212665, 3143.9842800786078, 3215.742740580771, 26456.603150952753, 26731.218034659196, 27110.50892200928, 27504.03735869235, 27624.171274861787, 3357.6642335766473, 3469.3234819210265, 3498.5276987606603, 3550.8579656813695, 3598.0, 228691.0, 228866.0, 229462.0, 230736.0, 231029.0, 49174.262386064234, 49397.0, 49482.505174947786, 49491.50508494941, 49497.75251123722, 31103.377932441224, 53016.20475692867, 53095.03574463861, 53095.46904530982, 53180.468195318324, 13958.511452099128, 14821.77767333491, 14865.331060102322, 14905.105693658415, 14964.625884352978, 10393.740156496147, 10429.21780866438, 10444.68665940023, 10463.94768026155, 10467.267291289689, 16974.57563560921, 17013.574660633334, 17044.829551704323, 17045.829541704672, 17374.826251737573, 6604.240512341143, 6654.567453115532, 6697.531172817856, 6727.899081513683, 6803.455723542104, 747.9065116860393, 838.1409055717938, 854.5940678177816, 919.5494207838245, 936.6487567162314, 24650.630240546405, 26925.0, 26977.460450790873, 27051.594226086625, 27281.45437091247, 732.7874916274221, 766.8197973476229, 868.891388576428, 934.6168071090956, 973.245734555725, 12512.74974500523, 13833.308334583231, 14093.506727264497, 14190.929045354913, 14323.713525729427, 342205.0, 448102.0, 453940.0, 453979.0, 455081.0, 49197.0, 49859.0, 49883.501164988615, 49961.00623900231, 50064.24903626448, 1036.5542816588788, 1111.7832022755647, 1112.844201811747, 1187.6080893305189, 1213.8968187704145, 22423.887880560495, 26999.730002700508, 28984.855075724485, 30763.0, 31225.37549249048, 46310.768446157555, 47113.293300599835, 47228.52771472241, 47425.99999999862, 47472.28791568198, 249242.0, 249493.0, 251616.0, 252535.0, 252981.0, 24349.87825060934, 24506.75493245116, 24787.504249915262, 24928.875355623106, 24955.63098981687, 39608.40587391249, 40524.79737601293, 40841.38737918993, 41031.38452923149, 41176.38235426531, 34308.31383372368, 34431.0, 34516.82741586276, 34977.825110874284, 35365.82317088398, 34258.65741342655, 34454.31091378108, 34707.0, 34752.65247347494, 34839.825800870836, 33866.49200262047, 34238.14404639904, 34624.653753462146, 35057.8247108773, 35104.82447587746, 29160.0, 31348.843255783577, 31781.36437271288, 32032.83983580067, 32086.51870221902, 24031.0, 24299.757002430455, 24627.63058554159, 24792.0, 24802.25593232134], "value": 16821.234277529635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.8124906305279, 321.9871205151794, 327.43517432429064, 335.5570646746295, 341.53039570590437, 12181.269123852564, 13256.270905100215, 13567.253801040939, 13572.457101715945, 15128.319225634832, 14922.328495217715, 15860.920695396508, 16252.349906003745, 16408.917955410205, 16574.75137872933, 4682.882927926804, 4697.295405689139, 4918.975405122969, 4924.359833221676, 4926.704397736147, 4796.448408433022, 4919.335889654904, 4927.260910863363, 4933.950660493403, 4934.851954441355, 5011.824586139486, 5297.337832770903, 5308.362996440433, 5337.172738225562, 5365.141577347626, 5090.083784918713, 5252.133397989327, 5284.4187139414635, 5286.788528458857, 5287.101192797214, 5123.436421993578, 5155.690658560461, 5160.071187186305, 5164.431912489623, 5168.2764412982215, 11191.104711623051, 11477.655670329903, 11555.711107222303, 18059.729104063448, 18997.955112468808, 1733.0554847607957, 1790.498660375097, 1851.7129844873932, 1918.6162767446426, 2022.1810166882435, 8591.785205369853, 8865.379423440361, 8867.600957956907, 9156.130167634064, 9166.358354915159, 1649.9010059396476, 1735.5921358480748, 1752.5881417866792, 1761.7445470406847, 1768.089433941521, 62386.37613623851, 66587.66706166486, 66902.66548667225, 68077.0, 69465.30534694639, 8824.911750882537, 8832.293416526663, 8903.73288801337, 9041.819163616823, 9189.862152067724, 12054.276743395249, 12107.697307567205, 12109.878901211052, 12117.21238119537, 12134.57528986499, 6863.210730766026, 7037.437005039585, 7079.610621415872, 7168.964155179295, 7237.819054523574, 6813.693383797642, 6859.279775623588, 6889.793306200822, 7047.89428158578, 7056.611886346198, 3792.867249646249, 3858.357025437584, 3911.47195128654, 3944.3294639911283, 4111.835526578963, 1568.6078480379906, 1739.6085880676999, 1813.7642106526066, 1826.7351234070986, 1870.2892900697648, 723.6960476599841, 861.2033868671454, 877.7542288159326, 892.848215803315, 912.4890061565544, 15879.444219452263, 16184.838151618333, 16729.749053764204, 16948.23732932021, 17217.225224864662, 834.3325339728193, 834.845553572591, 846.9745907622781, 849.6389034660244, 854.03920589337, 9064.229540489132, 9183.724488265363, 9235.861462078074, 9702.223822094216, 10233.641822536176, 390361.0, 394642.0, 403475.0, 404871.0, 407094.0, 77221.61389193017, 79759.60120199362, 79772.60113699394, 80450.59774701206, 84316.0, 879.6217626420572, 925.9074092590687, 937.3672770879629, 964.7732782796037, 965.5027660754716, 10997.780044399227, 14253.857461425669, 14643.780343294646, 15203.467878624195, 15733.921330393276, 36340.81829590835, 36404.453933190496, 36741.0, 36931.0, 37650.0, 46455.0, 48201.60068786553, 48225.5177448221, 49247.26129108138, 49884.25173622471, 6350.650714210763, 7172.39034682037, 7283.235260297804, 7348.338649521569, 8022.157673444204, 11489.655310340702, 11686.357250351311, 11903.880961190624, 11923.76152476963, 12086.648895583268, 10546.0, 10551.683449496528, 10558.419286939292, 10644.095251903675, 11153.721156970816, 10467.895321046692, 10647.520861561403, 10795.40625265618, 10803.189760767817, 10897.564097436014, 10614.840777388192, 10646.946765266124, 10661.57353705874, 10826.67519974402, 11188.216824822184, 6584.473242140713, 6835.93164068353, 6972.6862291196, 7183.066201393785, 7256.238094999949, 8943.463392196229, 10566.577336906437, 10582.576696932036, 10720.303180293256, 10750.677479675622], "value": 7843.300344748327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.4434865182297, 1348.9258090805006, 1391.7564426225408, 1576.90538567686, 1621.505440840543, 6687.264400915901, 7114.110736157973, 7117.359437650611, 7118.3949364304035, 7122.8575428491395, 6016.639001659903, 6222.937770622292, 6662.367075127855, 6908.7236510539515, 6913.343232392927, 2000.7899170587061, 2025.9797402025938, 2034.0846619021424, 2035.3181684135832, 2036.5621391400846, 2000.5598768270956, 2002.78970708075, 2030.2285131649953, 2040.1125510402949, 2042.9897850510727, 1740.9651806963852, 1810.8008119106887, 1960.1179469238828, 2024.6456870047757, 2027.7668068172202, 1999.8800071995654, 2014.6776515757408, 2020.686793546988, 2022.4741567192636, 2023.4334386371693, 2015.4558269267216, 2043.52998810273, 2046.8976551172382, 2050.4053824390908, 2052.938411847647, 6997.160340759091, 7178.246284140195, 7183.89224161638, 7192.748253811092, 7193.388561972239, 4191.203671302474, 4347.586979236968, 4347.978260108679, 4348.543402942677, 4350.825966961318, 2553.553128202557, 2763.9723602763916, 2787.1499192746205, 2811.409603983166, 2826.802123851331, 833.3291700181352, 858.1590041759049, 865.9004214515348, 885.5173930207987, 891.2869704236649, 9330.906690933072, 9355.204807591432, 9372.062793720641, 9382.155605995426, 9387.249020078378, 3602.837872295753, 3784.2242340320167, 3788.2991646544924, 3876.089119057019, 3876.2441323942126, 7615.847683046308, 7623.199564045695, 7627.970224019687, 7634.045744281965, 7638.236176382428, 4203.726757760735, 4222.514410842792, 4224.556421575752, 4226.1758957003085, 4226.4716910386205, 3701.833417496219, 3864.091938394475, 3865.594112618191, 3869.3035253654048, 3869.787161706077, 3269.2317305433203, 3293.3413317336626, 3349.8995030149135, 3379.7972121672287, 3386.3227354529195, 1058.6823952814125, 1068.4123731947552, 1084.983725244122, 1095.5124969388546, 1116.3692513729716, 629.3423372575578, 657.6645910585636, 712.7327252280395, 820.9671613135407, 835.532102022857, 4775.856724298207, 4933.531314525115, 4960.156773348539, 4973.2540118981715, 5048.495150484922, 825.2490233887133, 834.7161964931952, 877.1886005444937, 878.9208971192495, 889.0709208876739, 3355.7650964432255, 3439.793612383265, 3453.2575496268423, 3468.341015207153, 3559.5906470755676, 8246.83506329882, 8648.221660050625, 8664.740057798275, 8677.435966662148, 8678.349123815738, 8617.95691021541, 8619.655213791379, 8627.78430539229, 8629.913700862911, 8638.524881131598, 6490.0, 6551.312112228243, 6567.1462709848365, 6689.46484281266, 6690.2306234782645, 4775.5224477551965, 4787.521247875324, 4817.494163112963, 4854.781534831011, 4898.118338698926, 7594.582297973665, 7749.7287594933905, 7755.7673269802, 7833.020872390951, 7863.764087077397, 7845.450818442654, 7860.449768516149, 7923.920760792318, 7957.482763620346, 7997.400194985283, 5787.131930210502, 5805.651660900359, 5832.241808565029, 5868.471837534642, 5928.8814223716145, 6492.285848556749, 6522.836929076621, 6534.346565343428, 6540.313267106885, 6541.0, 6120.112583675431, 6220.346863579259, 6300.369963003846, 6402.519811014286, 6419.261784894797, 6142.416470435302, 6142.938570614416, 6160.507159427325, 6184.134221209124, 6234.376562343729, 5608.6073974821375, 5739.426057394227, 5748.281464816898, 5748.942510575008, 5750.913736293875, 4335.132973405394, 4350.978245108754, 4369.563043695732, 4492.2587773017085, 4507.09858028389, 4302.612764851178, 4343.587359200871, 4360.280553708602, 4403.691741578059, 4419.756913369795], "value": 3783.8469747217714, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.8776606643977, 274.17473405050794, 274.90240964457615, 286.6116412261387, 287.15433049668724, 4565.863024109273, 4701.341812146298, 4724.3858298421155, 4734.7159170449795, 4749.311349854269, 4558.769132334268, 4675.579197872191, 4679.15775160471, 4695.272232803913, 4702.800785799616, 3458.7029863801076, 3577.749557530974, 3680.11677197472, 3690.6678398944223, 3702.722560716555, 3599.4960705501253, 3693.9445908311395, 3696.611855755147, 3702.4446333049987, 3708.462272970418, 3664.5602527696715, 3683.189698266377, 3684.281565094808, 3685.7419980601367, 3696.445533170019, 3692.7230457715646, 3699.648533389324, 3714.53568303962, 3727.496787933635, 3730.253949210142, 3151.5745374374396, 3163.557102005721, 3179.888703895376, 3199.4720871056247, 3304.487804390323, 4559.133764584718, 4560.475545312298, 4561.361409402653, 4563.931541026887, 4588.862334129982, 3932.0, 4124.628783409477, 4130.607592278729, 4133.235351459959, 4136.366135376509, 4830.227163653799, 4854.320395144682, 4891.510848915115, 4898.461169271377, 4917.8278760243575, 3416.777909435879, 3416.8120753358558, 3417.3165366926464, 3445.2592692570965, 3472.8437220325145, 5140.151874940593, 5147.124988751922, 5156.587473002189, 5160.612954028463, 5172.6379153459275, 3397.21863971288, 3441.500982357544, 3486.065233795268, 3491.5810102787827, 3502.2120022994623, 3506.0, 3524.700400465938, 3529.0, 3529.594096678915, 3555.1467647764352, 4027.154297597537, 4077.836886524565, 4081.4898137732785, 4111.7944102794745, 4117.814698338582, 4671.416072990876, 4727.220008698595, 4857.878553036132, 4889.555222388805, 4915.926261106087, 1163.8777928317575, 1172.8271728271727, 1177.5643012085584, 1179.8289248058984, 1182.4974385885964, 792.3372522162672, 815.0789607743212, 823.7981694484889, 827.8947604947463, 830.33158307563, 4257.446531950888, 4264.744115353026, 4267.679924005712, 4287.935680964788, 4312.805923733439, 4913.631477639191, 4931.3835770528685, 4951.777170027357, 4952.529509696573, 4981.676191047571, 4278.679099067583, 4291.892702682396, 4305.375720520507, 4305.612494875476, 4335.154644844225, 2472.8134978554754, 2578.23941937129, 2591.5464793661035, 2601.583746600535, 2617.5395128579075, 4573.954260457419, 4574.794134263966, 4599.586037256663, 4607.424071991001, 4610.97694511532, 4990.0, 4990.8752281193265, 4995.375578052744, 4995.850124496198, 4999.375078115236, 4359.520452750195, 4504.869115964373, 4546.272056913299, 4561.543845615412, 4603.9079218415445, 4853.635977301646, 4865.902681946271, 4883.560479556715, 4887.486813884633, 4909.656324057424, 4768.713877167381, 4789.880252993703, 4806.279058141306, 4816.759162041954, 4825.5174482551465, 4446.244138496399, 4552.567506086916, 4553.977230113828, 4561.863144105682, 4572.497025327145, 3375.594928608583, 3387.525746395556, 3397.371486275047, 3397.677220664033, 3421.6065152506785, 4855.6115510758345, 4911.287863259736, 4959.677620954771, 4964.801407943786, 4995.5004499551205, 4791.346985290069, 4870.756462176948, 4920.753962301942, 4934.5312195341385, 4953.975230123826, 4919.237518184687, 4921.557059864629, 4928.905215283418, 4931.457539670705, 4931.827386041471, 4750.619950404029, 4862.781174847211, 4872.43966943806, 4880.169936273897, 4890.6087512998165, 4937.728424936663, 4937.8889749806, 4939.259111133359, 4976.32819569368, 4983.202687569971, 4854.75726213695, 4855.1988921828915, 4863.659543831898, 4865.885833066911, 4866.7079975201605], "value": 3642.2526343898603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.3402660193495, 667.456023340977, 686.6806934775328, 707.3739740329809, 715.4777012780673, 11426.42867856607, 12268.570600029001, 12271.693207669812, 12276.263424194554, 12286.754264914718, 10791.892081079186, 10798.838017429745, 10808.405537695424, 10833.458327083654, 10853.077488413493, 594.2927915780218, 613.4846728747851, 737.8524295140967, 756.4553521464537, 766.4136935244543, 766.3562607409775, 768.1128296817158, 768.5311959704603, 768.6694721269852, 769.8113962079299, 820.4953953318695, 821.4332110843499, 821.4619424277079, 822.01358369956, 822.0505316359614, 625.0592857749082, 645.4578154350321, 778.3695206882443, 801.4750338528273, 804.4007214625083, 590.0411830774991, 590.344717363726, 590.35356284868, 590.8729623131047, 590.9231799866033, 12024.218425802383, 12048.819267710991, 12060.396980150957, 12065.577704780291, 12066.155369124164, 11664.35846028468, 11666.766664666744, 12081.818772718416, 12083.697907552294, 12258.0, 10902.236843420964, 10918.945405273002, 11058.944705276423, 11265.831012534736, 11310.0, 3956.188981258835, 3958.5051868516434, 3967.543732470774, 4002.459667944819, 4028.5165780106577, 41939.161216775494, 45041.54958450439, 45046.09907801858, 45174.77412612916, 45481.0, 9707.563159657691, 10028.147607453448, 10196.082352588302, 10250.0, 10380.480975951172, 16253.431129910396, 16917.577060573585, 16969.83030169707, 17736.0, 17741.911290443724, 6346.682665866688, 6396.360363963567, 6590.703418346186, 6722.428593569503, 6885.345892140239, 3501.6848483636086, 3542.8405721742583, 3587.264610754789, 3592.8203589820405, 3632.20091579852, 2663.1744159310288, 2695.6899956504863, 2718.388362618395, 2720.7415295546894, 2728.113363156982, 469.63368572513497, 469.694698446006, 480.0518975024369, 482.96377771667267, 490.38701622971286, 510.77525888609637, 544.5425842292493, 571.9761626688181, 600.7687040489443, 619.3651507205151, 7339.70641174347, 7349.30181632744, 7497.1753107158165, 7874.921250787534, 7918.762437126896, 504.7829433343624, 530.3794560364383, 577.9364269930304, 609.2719200555382, 615.8521954730833, 3413.5221069050353, 3443.7933723976644, 3481.7562770606323, 3527.700145487611, 3627.147620309225, 66920.6653966727, 69694.3030569698, 69898.0, 73175.63412182905, 73251.63374183202, 60217.0, 60758.39241607527, 60852.69573652192, 61153.0, 63651.0, 55505.72247138739, 56037.159442607575, 56388.0, 56498.43501565014, 56559.0, 6717.697703603252, 6737.865242695217, 6865.519413640997, 7117.3238542338395, 7171.247019063132, 38058.0, 39519.80240098781, 39816.800915995234, 39933.80033099816, 40747.796261018506, 48138.5186148134, 48948.75525622349, 51525.7423712879, 53278.46721532735, 53304.0, 9657.517124143906, 9834.459104749307, 10005.699829005142, 10087.646932357333, 10222.437765922945, 11349.773004540028, 11678.0, 11718.765624687288, 11739.23694959825, 11908.40457977115, 11411.201215914807, 11577.421128943352, 11688.649340519798, 11702.590409335633, 12244.326562039174, 10848.728781780519, 11290.0, 11359.318440893572, 11630.418479075843, 11684.415779211175, 10468.371897686164, 11216.66350009501, 11500.597479088192, 11778.823317650413, 11791.469383877575, 9274.304427168125, 10009.749756256151, 10018.998100189923, 10029.598816047568, 10423.42671153094, 8895.421797583136, 9185.954070229605, 9702.9029709702, 9745.269104817025, 9808.705738827846], "value": 6029.961531293079, "unit": "score"}], "name": "dromaeo_css", "value": 6074.958184319914, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 116.0, 118.0, 115.0, 117.0, 115.0, 116.0, 116.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 128.0, 130.0, 162.0, 132.0, 134.0, 128.0, 134.0, 164.0, 132.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 104.0, 77.0, 76.0, 77.0, 75.0, 97.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 132.0, 83.0, 84.0, 83.0, 114.0, 84.0, 83.0, 116.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 70.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 83.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 150.0, 144.0, 143.0, 152.0, 145.0, 138.0, 205.0, 145.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 183.0, 179.0, 185.0, 183.0, 180.0, 181.0, 184.0, 184.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 69.0, 69.0, 70.0, 72.0, 70.0, 71.0, 70.0, 68.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1560.8000000000002, "alertThreshold": 2.0}]} 07:57:58 INFO - Return code: 0 07:57:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:57:58 INFO - # TBPL SUCCESS # 07:57:58 INFO - Running post-action listener: _resource_record_post_action 07:57:58 INFO - [mozharness: 2016-11-11 15:57:58.801436Z] Finished run-tests step (success) 07:57:58 INFO - Running post-run listener: _resource_record_post_run 07:57:58 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407621632; Read time: 12; Write time: 255388 07:57:58 INFO - TinderboxPrint: CPU usage
13.1% 07:57:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:57:58 INFO - TinderboxPrint: I/O write bytes / time
407,621,632 / 255,388 07:57:58 INFO - TinderboxPrint: CPU idle
8,340.9 (86.9%) 07:57:58 INFO - TinderboxPrint: CPU user
1,210.9 (12.6%) 07:57:58 INFO - TinderboxPrint: Swap in / out
0 / 0 07:57:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 116113408; Read time: 0; Write time: 60148 07:57:58 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290357248; Read time: 0; Write time: 195144 07:57:59 INFO - Running post-run listener: _upload_blobber_files 07:57:59 INFO - Blob upload gear active. 07:57:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:57:59 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 07:57:59 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'] 07:57:59 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 07:57:59 INFO - (blobuploader) - INFO - Open directory for files ... 07:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:03 INFO - (blobuploader) - INFO - Done attempting. 07:58:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:58:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:58:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:04 INFO - (blobuploader) - INFO - Done attempting. 07:58:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:58:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:58:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:04 INFO - (blobuploader) - INFO - Done attempting. 07:58:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:04 INFO - Return code: 0 07:58:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf77869a219285a7785f288506f8677a48b4c1c9413a51d6128450acabe4f4e949dc473f7ac85e6e2d1ca5e11b3d4b3fbb6d1ba7865c14411e528aad96f53b32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4c80d481e26a3b20df1d9c6f87be450f080ba7b4c40bc70e611b4e4db7ef62f82bc1ac59fd37da6c84c8ba6d78c22f6621c4127f2227c92e418a25d1f8df507", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f2ed90eebf694b3a78e570d0c9b64800daba7c8cd561f38a960e920aabd445868d669a5f08327d857ba66c35e63c9598d0ad194a610649d232674b2a5e2847f"} 07:58:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:04 INFO - Contents: 07:58:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf77869a219285a7785f288506f8677a48b4c1c9413a51d6128450acabe4f4e949dc473f7ac85e6e2d1ca5e11b3d4b3fbb6d1ba7865c14411e528aad96f53b32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4c80d481e26a3b20df1d9c6f87be450f080ba7b4c40bc70e611b4e4db7ef62f82bc1ac59fd37da6c84c8ba6d78c22f6621c4127f2227c92e418a25d1f8df507", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f2ed90eebf694b3a78e570d0c9b64800daba7c8cd561f38a960e920aabd445868d669a5f08327d857ba66c35e63c9598d0ad194a610649d232674b2a5e2847f"} 07:58:04 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:04 INFO - Copying logs to upload dir... 07:58:04 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.279276 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-11 07:58:04.421008) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 07:58:04.424743) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345 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/bf77869a219285a7785f288506f8677a48b4c1c9413a51d6128450acabe4f4e949dc473f7ac85e6e2d1ca5e11b3d4b3fbb6d1ba7865c14411e528aad96f53b32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4c80d481e26a3b20df1d9c6f87be450f080ba7b4c40bc70e611b4e4db7ef62f82bc1ac59fd37da6c84c8ba6d78c22f6621c4127f2227c92e418a25d1f8df507", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f2ed90eebf694b3a78e570d0c9b64800daba7c8cd561f38a960e920aabd445868d669a5f08327d857ba66c35e63c9598d0ad194a610649d232674b2a5e2847f"} build_url:https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/NAKkcY7MQfedysnsfuCwJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bf77869a219285a7785f288506f8677a48b4c1c9413a51d6128450acabe4f4e949dc473f7ac85e6e2d1ca5e11b3d4b3fbb6d1ba7865c14411e528aad96f53b32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4c80d481e26a3b20df1d9c6f87be450f080ba7b4c40bc70e611b4e4db7ef62f82bc1ac59fd37da6c84c8ba6d78c22f6621c4127f2227c92e418a25d1f8df507", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f2ed90eebf694b3a78e570d0c9b64800daba7c8cd561f38a960e920aabd445868d669a5f08327d857ba66c35e63c9598d0ad194a610649d232674b2a5e2847f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 07:58:04.450908) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 07:58:04.451262) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478877187.42089-1305656345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 07:58:04.533077) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 07:58:04.533411) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 07:58:04.533719) ========= ========= Total master_lag: 0.17 =========