builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1476185534.91 results: success (0) buildid: 20161011030247 builduid: db79f8d2e6df457ba7203ca60d65dced revision: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:14.912926) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:14.913324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:14.913625) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:14.963064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:14.963392) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 04:32: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-10-11 04:32:16 (103 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:15.102157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:15.102483) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018909 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:15.153537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 04:32:15.153895) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7ae377917236b7e6111146aa9fb4c073c0efc7f4 --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 7ae377917236b7e6111146aa9fb4c073c0efc7f4 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 04:32:16,404 truncating revision to first 12 chars 2016-10-11 04:32:16,404 Setting DEBUG logging. 2016-10-11 04:32:16,404 attempt 1/10 2016-10-11 04:32:16,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7ae377917236?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 04:32:17,180 unpacking tar archive at: mozilla-central-7ae377917236/testing/mozharness/ program finished with exit code 0 elapsedTime=1.145574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 04:32:16.317168) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:16.317982) ========= script_repo_revision: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:16.318940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:16.319643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 04:32:16.331767) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-11 04:32:16.332068) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:32:17 INFO - MultiFileLogger online at 20161011 04:32:17 in /builds/slave/test 04:32: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 04:32:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:32:17 INFO - {'append_to_log': False, 04:32:17 INFO - 'base_work_dir': '/builds/slave/test', 04:32:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:32:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:32:17 INFO - 'branch': 'Firefox-Non-PGO', 04:32:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:32:17 INFO - 'config_files': ('talos/linux_config.py',), 04:32:17 INFO - 'default_actions': ('clobber', 04:32:17 INFO - 'read-buildbot-config', 04:32:17 INFO - 'download-and-extract', 04:32:17 INFO - 'populate-webroot', 04:32:17 INFO - 'create-virtualenv', 04:32:17 INFO - 'install', 04:32:17 INFO - 'run-tests'), 04:32:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:32:17 INFO - 'download_minidump_stackwalk': True, 04:32:17 INFO - 'download_symbols': 'ondemand', 04:32:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:32:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:32:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:32:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:32:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:32:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:32:17 INFO - 'installer_path': 'installer.exe', 04:32:17 INFO - 'log_level': 'info', 04:32:17 INFO - 'log_name': 'talos', 04:32:17 INFO - 'log_to_console': True, 04:32:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:32:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:32:17 INFO - 'opt_config_files': (), 04:32:17 INFO - 'pip_index': False, 04:32:17 INFO - 'sps_profile': False, 04:32:17 INFO - 'sps_profile_interval': 0, 04:32:17 INFO - 'suite': 'dromaeojs', 04:32:17 INFO - 'system_bits': '32', 04:32:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:32:17 INFO - 'title': 'talos-linux64-ix-041', 04:32:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:32:17 INFO - 'use_talos_json': True, 04:32:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:32:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:32:17 INFO - 'work_dir': 'build'} 04:32:17 INFO - [mozharness: 2016-10-11 11:32:17.680464Z] Running clobber step. 04:32:17 INFO - Running pre-action listener: _resource_record_pre_action 04:32:17 INFO - Running main action method: clobber 04:32:17 INFO - rmtree: /builds/slave/test/build 04:32:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:32:18 INFO - Running post-action listener: _resource_record_post_action 04:32:18 INFO - [mozharness: 2016-10-11 11:32:18.138736Z] Finished clobber step (success) 04:32:18 INFO - [mozharness: 2016-10-11 11:32:18.138837Z] Running read-buildbot-config step. 04:32:18 INFO - Running pre-action listener: _resource_record_pre_action 04:32:18 INFO - Running main action method: read_buildbot_config 04:32:18 INFO - Using buildbot properties: 04:32:18 INFO - { 04:32:18 INFO - "project": "", 04:32:18 INFO - "product": "firefox", 04:32:18 INFO - "script_repo_revision": "production", 04:32:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:32:18 INFO - "repository": "", 04:32:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:32:18 INFO - "buildid": "20161011030247", 04:32:18 INFO - "pgo_build": "False", 04:32:18 INFO - "basedir": "/builds/slave/test", 04:32:18 INFO - "buildnumber": 666, 04:32:18 INFO - "slavename": "talos-linux64-ix-041", 04:32:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:32:18 INFO - "platform": "ubuntu64_hw", 04:32:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:32:18 INFO - "branch": "mozilla-central", 04:32:18 INFO - "repo_path": "mozilla-central", 04:32:18 INFO - "revision": "7ae377917236b7e6111146aa9fb4c073c0efc7f4", 04:32:18 INFO - "stage_platform": "linux64", 04:32:18 INFO - "builduid": "db79f8d2e6df457ba7203ca60d65dced", 04:32:18 INFO - "slavebuilddir": "test" 04:32:18 INFO - } 04:32:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:32:18 INFO - Running post-action listener: _resource_record_post_action 04:32:18 INFO - [mozharness: 2016-10-11 11:32:18.141343Z] Finished read-buildbot-config step (success) 04:32:18 INFO - [mozharness: 2016-10-11 11:32:18.141430Z] Running download-and-extract step. 04:32:18 INFO - Running pre-action listener: _resource_record_pre_action 04:32:18 INFO - Running main action method: download_and_extract 04:32:18 INFO - mkdir: /builds/slave/test/build/tests 04:32: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')]} 04:32:18 INFO - trying https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:32:18 INFO - Downloading https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:32:18 INFO - Downloaded 1361 bytes. 04:32:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:32:18 INFO - Using the following test package requirements: 04:32:18 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:32:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:32:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:18 INFO - u'jsshell-linux-x86_64.zip'], 04:32:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:32:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:32:18 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:32:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:32:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:32:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:32:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:32:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:32:18 INFO - Fetch https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:32:19 INFO - Http code: 200 04:32:19 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 04:32:19 INFO - x-amz-cf-id: Oh3E_2M20P1XQuOQFlUYEqC0IdHkfrGjFO3WDxerZovplZbV-rvT0A== 04:32:19 INFO - x-amz-version-id: AF6Y_f7rHSKzCM1FhMKllotbQWeLk4ud 04:32:19 INFO - Expected file size: 20528379 04:32:19 INFO - Obtained file size: 20528379 04:32:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:32:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:32:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:32:23 INFO - Fetch https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:32:24 INFO - Http code: 200 04:32:24 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 04:32:24 INFO - x-amz-cf-id: Mz5YVrR6SV8kWbtCwpzdwL-dPsEYu9nxRctNWZT_cwgDkqonvzsRSw== 04:32:24 INFO - x-amz-version-id: AF6Y_f7rHSKzCM1FhMKllotbQWeLk4ud 04:32:24 INFO - Expected file size: 20528379 04:32:24 INFO - Obtained file size: 20528379 04:32:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:32:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:32:28 INFO - Fetch https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:32:29 INFO - Http code: 200 04:32:29 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 04:32:29 INFO - x-amz-cf-id: hXgJKOS47zZeGJaWCo7hFRtXAmOSsUJ9B8jm0ZxiPTA7TCYwxWmqCQ== 04:32:29 INFO - x-amz-version-id: XWBH8dW.gTBV8niUNTAotaXQW4BQIzgd 04:32:29 INFO - Expected file size: 14409006 04:32:29 INFO - Obtained file size: 14409006 04:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:29 INFO - trying https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:32:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:32:31 INFO - Downloaded 55902567 bytes. 04:32:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:32:31 INFO - mkdir: /builds/slave/test/properties 04:32:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:31 INFO - Contents: 04:32:31 INFO - build_url:https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:32:31 INFO - Running post-action listener: _resource_record_post_action 04:32:31 INFO - Running post-action listener: set_extra_try_arguments 04:32:31 INFO - [mozharness: 2016-10-11 11:32:31.700219Z] Finished download-and-extract step (success) 04:32:31 INFO - [mozharness: 2016-10-11 11:32:31.700450Z] Running populate-webroot step. 04:32:31 INFO - Running pre-action listener: _resource_record_pre_action 04:32:31 INFO - Running main action method: populate_webroot 04:32:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:31 INFO - '--tppagecycles', 04:32:31 INFO - '7'], 04:32:31 INFO - 'tests': ['tsvgm']}}, 04:32:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:32:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:32:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:31 INFO - 'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:31 INFO - 'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['damp', 'tps']}, 04:32:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:31 INFO - 'tests': ['damp', 'tps']}, 04:32:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['dromaeo_dom']}, 04:32:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['basic_compositor_video']}, 04:32:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:32:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['a11yr', 04:32:31 INFO - 'ts_paint', 04:32:31 INFO - 'tpaint', 04:32:31 INFO - 'sessionrestore', 04:32:31 INFO - 'sessionrestore_no_auto_restore', 04:32:31 INFO - 'tabpaint']}, 04:32:31 INFO - 'other-e10s': {'tests': ['a11yr', 04:32:31 INFO - 'ts_paint', 04:32:31 INFO - 'tpaint', 04:32:31 INFO - 'sessionrestore', 04:32:31 INFO - 'sessionrestore_no_auto_restore', 04:32:31 INFO - 'tabpaint']}, 04:32:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:32:31 INFO - 'ts_paint', 04:32:31 INFO - 'tpaint', 04:32:31 INFO - 'sessionrestore', 04:32:31 INFO - 'sessionrestore_no_auto_restore', 04:32:31 INFO - 'tabpaint']}, 04:32:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:32:31 INFO - 'ts_paint', 04:32:31 INFO - 'tpaint', 04:32:31 INFO - 'sessionrestore', 04:32:31 INFO - 'sessionrestore_no_auto_restore', 04:32:31 INFO - 'tabpaint']}, 04:32:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['a11yr', 04:32:31 INFO - 'ts_paint', 04:32:31 INFO - 'tpaint', 04:32:31 INFO - 'sessionrestore', 04:32:31 INFO - 'sessionrestore_no_auto_restore', 04:32:31 INFO - 'tabpaint']}, 04:32:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['a11yr', 04:32:31 INFO - 'ts_paint', 04:32:31 INFO - 'tpaint', 04:32:31 INFO - 'sessionrestore', 04:32:31 INFO - 'sessionrestore_no_auto_restore', 04:32:31 INFO - 'tabpaint']}, 04:32:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['tsvgx', 04:32:31 INFO - 'tsvgr_opacity', 04:32:31 INFO - 'tart', 04:32:31 INFO - 'tscrollx', 04:32:31 INFO - 'cart']}, 04:32:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:32:31 INFO - 'tsvgr_opacity', 04:32:31 INFO - 'tart', 04:32:31 INFO - 'tscrollx', 04:32:31 INFO - 'cart']}, 04:32:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:31 INFO - 'talos_options': ['--disable-e10s'], 04:32:31 INFO - 'tests': ['tp5o']}, 04:32:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:31 INFO - 'tests': ['tp5o']}, 04:32:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:31 INFO - 'talos_options': ['--disable-e10s', 04:32:31 INFO - '--xperf_path', 04:32:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:31 INFO - 'tests': ['tp5n']}, 04:32:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:31 INFO - 'talos_options': ['--xperf_path', 04:32:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:31 INFO - 'tests': ['tp5n']}}, 04:32:31 INFO - 'talos.zip': {'path': '', 04:32:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:31 INFO - Running post-action listener: _resource_record_post_action 04:32:31 INFO - [mozharness: 2016-10-11 11:32:31.716177Z] Finished populate-webroot step (success) 04:32:31 INFO - [mozharness: 2016-10-11 11:32:31.716266Z] Running create-virtualenv step. 04:32:31 INFO - Running pre-action listener: _resource_record_pre_action 04:32:31 INFO - Running main action method: create_virtualenv 04:32:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:32:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:31 INFO - Using real prefix '/usr' 04:32:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:34 INFO - Installing pip.................done. 04:32:34 INFO - Return code: 0 04:32:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:32:34 INFO - Reading from file tmpfile_stdout 04:32:34 INFO - Output received: 04:32:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:32:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:34 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 0x7fb417350f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25efca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:32:34 INFO - Using env: {'DISPLAY': ':0', 04:32:34 INFO - 'HOME': '/home/cltbld', 04:32:34 INFO - 'LANG': 'en_US.UTF-8', 04:32:34 INFO - 'LANGUAGE': 'en_US:en', 04:32:34 INFO - 'LOGNAME': 'cltbld', 04:32:34 INFO - 'MAIL': '/var/mail/cltbld', 04:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:34 INFO - 'MOZ_NO_REMOTE': '1', 04:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:34 INFO - 'NO_EM_RESTART': '1', 04:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:34 INFO - 'PWD': '/builds/slave/test', 04:32:34 INFO - 'SHELL': '/bin/bash', 04:32:34 INFO - 'SHLVL': '1', 04:32:34 INFO - 'TERM': 'linux', 04:32:34 INFO - 'TMOUT': '86400', 04:32:34 INFO - 'USER': 'cltbld', 04:32:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:34 INFO - '_': '/tools/buildbot/bin/python'} 04:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:32:34 INFO - Cleaning up... 04:32:34 INFO - Return code: 0 04:32:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:34 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 0x7fb417350f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25efca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:32:34 INFO - Using env: {'DISPLAY': ':0', 04:32:34 INFO - 'HOME': '/home/cltbld', 04:32:34 INFO - 'LANG': 'en_US.UTF-8', 04:32:34 INFO - 'LANGUAGE': 'en_US:en', 04:32:34 INFO - 'LOGNAME': 'cltbld', 04:32:34 INFO - 'MAIL': '/var/mail/cltbld', 04:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:34 INFO - 'MOZ_NO_REMOTE': '1', 04:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:34 INFO - 'NO_EM_RESTART': '1', 04:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:34 INFO - 'PWD': '/builds/slave/test', 04:32:34 INFO - 'SHELL': '/bin/bash', 04:32:34 INFO - 'SHLVL': '1', 04:32:34 INFO - 'TERM': 'linux', 04:32:34 INFO - 'TMOUT': '86400', 04:32:34 INFO - 'USER': 'cltbld', 04:32:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:34 INFO - '_': '/tools/buildbot/bin/python'} 04:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:34 INFO - Downloading/unpacking psutil>=3.1.1 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:36 INFO - Installing collected packages: psutil 04:32:36 INFO - Running setup.py install for psutil 04:32:37 INFO - building 'psutil._psutil_linux' extension 04:32: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 04:32:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:32:37 INFO - building 'psutil._psutil_posix' extension 04:32:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:32:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:32:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:37 INFO - Successfully installed psutil 04:32:37 INFO - Cleaning up... 04:32:37 INFO - Return code: 0 04:32:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:37 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 0x7fb417350f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25efca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:32:37 INFO - Using env: {'DISPLAY': ':0', 04:32:37 INFO - 'HOME': '/home/cltbld', 04:32:37 INFO - 'LANG': 'en_US.UTF-8', 04:32:37 INFO - 'LANGUAGE': 'en_US:en', 04:32:37 INFO - 'LOGNAME': 'cltbld', 04:32:37 INFO - 'MAIL': '/var/mail/cltbld', 04:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:37 INFO - 'MOZ_NO_REMOTE': '1', 04:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:37 INFO - 'NO_EM_RESTART': '1', 04:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:37 INFO - 'PWD': '/builds/slave/test', 04:32:37 INFO - 'SHELL': '/bin/bash', 04:32:37 INFO - 'SHLVL': '1', 04:32:37 INFO - 'TERM': 'linux', 04:32:37 INFO - 'TMOUT': '86400', 04:32:37 INFO - 'USER': 'cltbld', 04:32:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:37 INFO - '_': '/tools/buildbot/bin/python'} 04:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:39 INFO - Installing collected packages: mozsystemmonitor 04:32:39 INFO - Running setup.py install for mozsystemmonitor 04:32:39 INFO - Successfully installed mozsystemmonitor 04:32:39 INFO - Cleaning up... 04:32:39 INFO - Return code: 0 04:32:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:39 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 0x7fb417350f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25efca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:32:39 INFO - Using env: {'DISPLAY': ':0', 04:32:39 INFO - 'HOME': '/home/cltbld', 04:32:39 INFO - 'LANG': 'en_US.UTF-8', 04:32:39 INFO - 'LANGUAGE': 'en_US:en', 04:32:39 INFO - 'LOGNAME': 'cltbld', 04:32:39 INFO - 'MAIL': '/var/mail/cltbld', 04:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:39 INFO - 'MOZ_NO_REMOTE': '1', 04:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:39 INFO - 'NO_EM_RESTART': '1', 04:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:39 INFO - 'PWD': '/builds/slave/test', 04:32:39 INFO - 'SHELL': '/bin/bash', 04:32:39 INFO - 'SHLVL': '1', 04:32:39 INFO - 'TERM': 'linux', 04:32:39 INFO - 'TMOUT': '86400', 04:32:39 INFO - 'USER': 'cltbld', 04:32:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:39 INFO - '_': '/tools/buildbot/bin/python'} 04:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:40 INFO - Downloading/unpacking jsonschema==2.5.1 04:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:42 INFO - warning: no files found matching '*.txt' 04:32:42 INFO - no previously-included directories found matching 'build' 04:32:42 INFO - no previously-included directories found matching 'dist' 04:32:42 INFO - no previously-included directories found matching '.git*' 04:32:42 INFO - Installing collected packages: jsonschema, functools32 04:32:42 INFO - Running setup.py install for functools32 04:32:42 INFO - warning: no files found matching '*.txt' 04:32:42 INFO - no previously-included directories found matching 'build' 04:32:42 INFO - no previously-included directories found matching 'dist' 04:32:42 INFO - no previously-included directories found matching '.git*' 04:32:42 INFO - Successfully installed jsonschema functools32 04:32:42 INFO - Cleaning up... 04:32:42 INFO - Return code: 0 04:32:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:42 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 0x7fb417350f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25efca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:32:42 INFO - Using env: {'DISPLAY': ':0', 04:32:42 INFO - 'HOME': '/home/cltbld', 04:32:42 INFO - 'LANG': 'en_US.UTF-8', 04:32:42 INFO - 'LANGUAGE': 'en_US:en', 04:32:42 INFO - 'LOGNAME': 'cltbld', 04:32:42 INFO - 'MAIL': '/var/mail/cltbld', 04:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:42 INFO - 'MOZ_NO_REMOTE': '1', 04:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:42 INFO - 'NO_EM_RESTART': '1', 04:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:42 INFO - 'PWD': '/builds/slave/test', 04:32:42 INFO - 'SHELL': '/bin/bash', 04:32:42 INFO - 'SHLVL': '1', 04:32:42 INFO - 'TERM': 'linux', 04:32:42 INFO - 'TMOUT': '86400', 04:32:42 INFO - 'USER': 'cltbld', 04:32:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:42 INFO - '_': '/tools/buildbot/bin/python'} 04:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:32:42 INFO - Cleaning up... 04:32:42 INFO - Return code: 0 04:32:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:42 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 0x7fb417350f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25efca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:32:42 INFO - Using env: {'DISPLAY': ':0', 04:32:42 INFO - 'HOME': '/home/cltbld', 04:32:42 INFO - 'LANG': 'en_US.UTF-8', 04:32:42 INFO - 'LANGUAGE': 'en_US:en', 04:32:42 INFO - 'LOGNAME': 'cltbld', 04:32:42 INFO - 'MAIL': '/var/mail/cltbld', 04:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:42 INFO - 'MOZ_NO_REMOTE': '1', 04:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:42 INFO - 'NO_EM_RESTART': '1', 04:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:42 INFO - 'PWD': '/builds/slave/test', 04:32:42 INFO - 'SHELL': '/bin/bash', 04:32:42 INFO - 'SHLVL': '1', 04:32:42 INFO - 'TERM': 'linux', 04:32:42 INFO - 'TMOUT': '86400', 04:32:42 INFO - 'USER': 'cltbld', 04:32:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:42 INFO - '_': '/tools/buildbot/bin/python'} 04:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:45 INFO - Downloading docopt-0.6.1.tar.gz 04:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:45 INFO - Running setup.py install for blobuploader 04:32:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:45 INFO - Running setup.py install for requests 04:32:46 INFO - Running setup.py install for docopt 04:32:46 INFO - Successfully installed blobuploader requests docopt 04:32:46 INFO - Cleaning up... 04:32:46 INFO - Return code: 0 04:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:46 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 0x7fb417350f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25efca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:46 INFO - Using env: {'DISPLAY': ':0', 04:32:46 INFO - 'HOME': '/home/cltbld', 04:32:46 INFO - 'LANG': 'en_US.UTF-8', 04:32:46 INFO - 'LANGUAGE': 'en_US:en', 04:32:46 INFO - 'LOGNAME': 'cltbld', 04:32:46 INFO - 'MAIL': '/var/mail/cltbld', 04:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:46 INFO - 'MOZ_NO_REMOTE': '1', 04:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:46 INFO - 'NO_EM_RESTART': '1', 04:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:46 INFO - 'PWD': '/builds/slave/test', 04:32:46 INFO - 'SHELL': '/bin/bash', 04:32:46 INFO - 'SHLVL': '1', 04:32:46 INFO - 'TERM': 'linux', 04:32:46 INFO - 'TMOUT': '86400', 04:32:46 INFO - 'USER': 'cltbld', 04:32:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:46 INFO - '_': '/tools/buildbot/bin/python'} 04:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:46 INFO - Running setup.py (path:/tmp/pip-jy3C5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:46 INFO - Running setup.py (path:/tmp/pip-Scu1qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:46 INFO - Running setup.py (path:/tmp/pip-wZ7RqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:46 INFO - Running setup.py (path:/tmp/pip-fDrj3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:46 INFO - Running setup.py (path:/tmp/pip-rg7G7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:46 INFO - Running setup.py (path:/tmp/pip-IhJQAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:46 INFO - Running setup.py (path:/tmp/pip-PA4Wb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:46 INFO - Running setup.py (path:/tmp/pip-tLvNxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:47 INFO - Running setup.py (path:/tmp/pip-ytdwxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:47 INFO - Running setup.py (path:/tmp/pip-lYdZuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:47 INFO - Running setup.py (path:/tmp/pip-pIXUoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:47 INFO - Running setup.py (path:/tmp/pip-lzeGed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:47 INFO - Running setup.py (path:/tmp/pip-UG6SSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:47 INFO - Running setup.py (path:/tmp/pip-Hs1R35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:47 INFO - Running setup.py (path:/tmp/pip-E0_j5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:47 INFO - Running setup.py (path:/tmp/pip-s8kacN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:47 INFO - Running setup.py (path:/tmp/pip-O58aqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:47 INFO - Running setup.py install for manifestparser 04:32:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:47 INFO - Running setup.py install for mozcrash 04:32:47 INFO - Running setup.py install for mozdebug 04:32:47 INFO - Running setup.py install for mozdevice 04:32:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for mozfile 04:32:48 INFO - Running setup.py install for mozhttpd 04:32:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for mozinfo 04:32:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for mozInstall 04:32:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for mozleak 04:32:48 INFO - Running setup.py install for mozlog 04:32:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for moznetwork 04:32:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:48 INFO - Running setup.py install for mozprocess 04:32:48 INFO - Running setup.py install for mozprofile 04:32:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Running setup.py install for mozrunner 04:32:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Running setup.py install for mozscreenshot 04:32:49 INFO - Running setup.py install for moztest 04:32:49 INFO - Running setup.py install for mozversion 04:32:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:49 INFO - Cleaning up... 04:32:49 INFO - Return code: 0 04:32:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:49 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 0x7fb417350f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25efca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:49 INFO - Using env: {'DISPLAY': ':0', 04:32:49 INFO - 'HOME': '/home/cltbld', 04:32:49 INFO - 'LANG': 'en_US.UTF-8', 04:32:49 INFO - 'LANGUAGE': 'en_US:en', 04:32:49 INFO - 'LOGNAME': 'cltbld', 04:32:49 INFO - 'MAIL': '/var/mail/cltbld', 04:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:49 INFO - 'MOZ_NO_REMOTE': '1', 04:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:49 INFO - 'NO_EM_RESTART': '1', 04:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:49 INFO - 'PWD': '/builds/slave/test', 04:32:49 INFO - 'SHELL': '/bin/bash', 04:32:49 INFO - 'SHLVL': '1', 04:32:49 INFO - 'TERM': 'linux', 04:32:49 INFO - 'TMOUT': '86400', 04:32:49 INFO - 'USER': 'cltbld', 04:32:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:49 INFO - '_': '/tools/buildbot/bin/python'} 04:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:49 INFO - Running setup.py (path:/tmp/pip-Q3LCQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:49 INFO - Running setup.py (path:/tmp/pip-xg5zkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:49 INFO - Running setup.py (path:/tmp/pip-mxfN51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:49 INFO - Running setup.py (path:/tmp/pip-e0eKG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32: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)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:50 INFO - Running setup.py (path:/tmp/pip-EJzF1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:50 INFO - Running setup.py (path:/tmp/pip-ypJL4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:50 INFO - Running setup.py (path:/tmp/pip-OmjHAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:50 INFO - Running setup.py (path:/tmp/pip-tlgiUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:50 INFO - Running setup.py (path:/tmp/pip-r0Ihk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:50 INFO - Running setup.py (path:/tmp/pip-4fwYp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:50 INFO - Running setup.py (path:/tmp/pip-OfZZbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:50 INFO - Running setup.py (path:/tmp/pip-quml4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:50 INFO - Running setup.py (path:/tmp/pip-ZGDt0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:50 INFO - Running setup.py (path:/tmp/pip-fO9l_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:50 INFO - Running setup.py (path:/tmp/pip-srJNdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:50 INFO - Running setup.py (path:/tmp/pip-pnuyu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:50 INFO - Running setup.py (path:/tmp/pip-sJnrN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:52 INFO - Downloading blessings-1.6.tar.gz 04:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:52 INFO - Installing collected packages: blessings 04:32:52 INFO - Running setup.py install for blessings 04:32:53 INFO - Successfully installed blessings 04:32:53 INFO - Cleaning up... 04:32:53 INFO - Return code: 0 04:32:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:53 INFO - Reading from file tmpfile_stdout 04:32:53 INFO - Current package versions: 04:32:53 INFO - argparse == 1.2.1 04:32:53 INFO - blessings == 1.6 04:32:53 INFO - blobuploader == 1.2.4 04:32:53 INFO - docopt == 0.6.1 04:32:53 INFO - functools32 == 3.2.3-2 04:32:53 INFO - jsonschema == 2.5.1 04:32:53 INFO - manifestparser == 1.1 04:32:53 INFO - mozInstall == 1.12 04:32:53 INFO - mozcrash == 0.17 04:32:53 INFO - mozdebug == 0.1 04:32:53 INFO - mozdevice == 0.48 04:32:53 INFO - mozfile == 1.2 04:32:53 INFO - mozhttpd == 0.7 04:32:53 INFO - mozinfo == 0.9 04:32:53 INFO - mozleak == 0.1 04:32:53 INFO - mozlog == 3.4 04:32:53 INFO - moznetwork == 0.27 04:32:53 INFO - mozprocess == 0.23 04:32:53 INFO - mozprofile == 0.28 04:32:53 INFO - mozrunner == 6.12 04:32:53 INFO - mozscreenshot == 0.1 04:32:53 INFO - mozsystemmonitor == 0.3 04:32:53 INFO - moztest == 0.7 04:32:53 INFO - mozversion == 1.4 04:32:53 INFO - psutil == 3.1.1 04:32:53 INFO - requests == 1.2.3 04:32:53 INFO - wsgiref == 0.1.2 04:32:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:53 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 0x7fb417350f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25efca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:53 INFO - Using env: {'DISPLAY': ':0', 04:32:53 INFO - 'HOME': '/home/cltbld', 04:32:53 INFO - 'LANG': 'en_US.UTF-8', 04:32:53 INFO - 'LANGUAGE': 'en_US:en', 04:32:53 INFO - 'LOGNAME': 'cltbld', 04:32:53 INFO - 'MAIL': '/var/mail/cltbld', 04:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:53 INFO - 'MOZ_NO_REMOTE': '1', 04:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:53 INFO - 'NO_EM_RESTART': '1', 04:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:53 INFO - 'PWD': '/builds/slave/test', 04:32:53 INFO - 'SHELL': '/bin/bash', 04:32:53 INFO - 'SHLVL': '1', 04:32:53 INFO - 'TERM': 'linux', 04:32:53 INFO - 'TMOUT': '86400', 04:32:53 INFO - 'USER': 'cltbld', 04:32:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:53 INFO - '_': '/tools/buildbot/bin/python'} 04:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:53 INFO - Cleaning up... 04:32:53 INFO - Return code: 0 04:32:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:53 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 0x7fb417350f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25efca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:32:53 INFO - Using env: {'DISPLAY': ':0', 04:32:53 INFO - 'HOME': '/home/cltbld', 04:32:53 INFO - 'LANG': 'en_US.UTF-8', 04:32:53 INFO - 'LANGUAGE': 'en_US:en', 04:32:53 INFO - 'LOGNAME': 'cltbld', 04:32:53 INFO - 'MAIL': '/var/mail/cltbld', 04:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:53 INFO - 'MOZ_NO_REMOTE': '1', 04:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:53 INFO - 'NO_EM_RESTART': '1', 04:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:53 INFO - 'PWD': '/builds/slave/test', 04:32:53 INFO - 'SHELL': '/bin/bash', 04:32:53 INFO - 'SHLVL': '1', 04:32:53 INFO - 'TERM': 'linux', 04:32:53 INFO - 'TMOUT': '86400', 04:32:53 INFO - 'USER': 'cltbld', 04:32:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:53 INFO - '_': '/tools/buildbot/bin/python'} 04:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:32:53 INFO - Cleaning up... 04:32:53 INFO - Return code: 0 04:32:53 INFO - Running post-action listener: _resource_record_post_action 04:32:53 INFO - Running post-action listener: _start_resource_monitoring 04:32:53 INFO - Starting resource monitoring. 04:32:53 INFO - [mozharness: 2016-10-11 11:32:53.881533Z] Finished create-virtualenv step (success) 04:32:53 INFO - [mozharness: 2016-10-11 11:32:53.882042Z] Running install step. 04:32:53 INFO - Running pre-action listener: _resource_record_pre_action 04:32:53 INFO - Running main action method: install 04:32:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:54 INFO - Reading from file tmpfile_stdout 04:32:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:54 INFO - Reading from file tmpfile_stdout 04:32:54 INFO - Output received: 04:32:54 INFO - Usage: mozinstall [options] installer 04:32:54 INFO - Options: 04:32:54 INFO - -h, --help show this help message and exit 04:32:54 INFO - -d DEST, --destination=DEST 04:32:54 INFO - Directory to install application into. [default: 04:32:54 INFO - "/builds/slave/test"] 04:32:54 INFO - --app=APP Application being installed. [default: firefox] 04:32:54 INFO - mkdir: /builds/slave/test/build/application 04:32:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:33:10 INFO - Reading from file tmpfile_stdout 04:33:10 INFO - Output received: 04:33:10 INFO - /builds/slave/test/build/application/firefox/firefox 04:33:10 INFO - Running post-action listener: _resource_record_post_action 04:33:10 INFO - [mozharness: 2016-10-11 11:33:10.345841Z] Finished install step (success) 04:33:10 INFO - [mozharness: 2016-10-11 11:33:10.346084Z] Running run-tests step. 04:33:10 INFO - Running pre-action listener: _resource_record_pre_action 04:33:10 INFO - Running main action method: run_tests 04:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:10 INFO - Python 2.7.3 04:33:10 INFO - Return code: 0 04:33:10 INFO - grabbing minidump binary from tooltool 04:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:10 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 0x25ecf60>, '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 0x25edd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ee1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:33:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:33:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:33:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:10 INFO - Return code: 0 04:33:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:33:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:33:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:10 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/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:33:10 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/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:33:10 INFO - Using env: {'DISPLAY': ':0', 04:33:10 INFO - 'HOME': '/home/cltbld', 04:33:10 INFO - 'LANG': 'en_US.UTF-8', 04:33:10 INFO - 'LANGUAGE': 'en_US:en', 04:33:10 INFO - 'LOGNAME': 'cltbld', 04:33:10 INFO - 'MAIL': '/var/mail/cltbld', 04:33:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:10 INFO - 'MOZ_NO_REMOTE': '1', 04:33:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:10 INFO - 'NO_EM_RESTART': '1', 04:33:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:10 INFO - 'PWD': '/builds/slave/test', 04:33:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:10 INFO - 'SHELL': '/bin/bash', 04:33:10 INFO - 'SHLVL': '1', 04:33:10 INFO - 'TERM': 'linux', 04:33:10 INFO - 'TMOUT': '86400', 04:33:10 INFO - 'USER': 'cltbld', 04:33:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193', 04:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:10 INFO - '_': '/tools/buildbot/bin/python'} 04:33:10 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/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:33:10 INFO - mozversion application_buildid: 20161011030247 04:33:10 INFO - mozversion application_changeset: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 04:33:10 INFO - mozversion application_display_name: Nightly 04:33:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:10 INFO - mozversion application_name: Firefox 04:33:10 INFO - mozversion application_remotingname: firefox 04:33:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:33:10 INFO - mozversion application_vendor: Mozilla 04:33:10 INFO - mozversion application_version: 52.0a1 04:33:10 INFO - mozversion platform_buildid: 20161011030247 04:33:10 INFO - mozversion platform_changeset: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 04:33:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:33:10 INFO - mozversion platform_version: 52.0a1 04:33:10 INFO - using testdate: 1476185590 04:33:10 INFO - actual date: 1476185590 04:33:10 INFO - starting webserver on 'localhost:55178' 04:33:10 INFO - SUITE-START | Running 2 tests 04:33:10 INFO - TEST-START | dromaeo_css 04:33:10 INFO - operating with platform_type : linux_ 04:33:10 INFO - Initialising browser for dromaeo_css test... 04:33:10 INFO - TEST-INFO | started process 17141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20okkA/profile http://localhost:55178/getInfo.html) 04:33:15 INFO - PROCESS | 17141 | __metrics Screen width/height:1600/1200 04:33:15 INFO - PROCESS | 17141 | colorDepth:24 04:33:15 INFO - PROCESS | 17141 | Browser inner width/height: 1024/697 04:33:15 INFO - PROCESS | 17141 | __metrics 04:33:15 INFO - PROCESS | 17141 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:33:15 INFO - PROCESS | 17141 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:16 INFO - PROCESS | 17141 | console.error: PushService: 04:33:16 INFO - PROCESS | 17141 | stateChangeProcessEnqueue: Error transitioning state 04:33:16 INFO - PROCESS | 17141 | UnknownError 04:33:17 INFO - TEST-INFO | 17141: exit 0 04:33:17 INFO - Browser initialized. 04:33:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:17 INFO - TEST-INFO | started process 17223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20okkA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:29 INFO - PROCESS | 17223 | RSS: Main: 174751744 04:33:29 INFO - PROCESS | 17223 | 04:34:21 INFO - PROCESS | 17223 | 1476185661153 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:36:34 INFO - PROCESS | 17223 | Cycle 1(1): loaded http://localhost:55178/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55178/tests/dromaeo/cssquery-ext.html) 04:36:35 INFO - PROCESS | 17223 | RSS: Main: 308228096 04:36:35 INFO - PROCESS | 17223 | 04:39:38 INFO - PROCESS | 17223 | Cycle 1(1): loaded http://localhost:55178/tests/dromaeo/cssquery-ext.html (next: http://localhost:55178/tests/dromaeo/cssquery-jquery.html) 04:39:38 INFO - PROCESS | 17223 | RSS: Main: 277323776 04:39:38 INFO - PROCESS | 17223 | 04:42:41 INFO - PROCESS | 17223 | Cycle 1(1): loaded http://localhost:55178/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55178/tests/dromaeo/cssquery-mootools.html) 04:42:41 INFO - PROCESS | 17223 | RSS: Main: 219062272 04:42:41 INFO - PROCESS | 17223 | 04:45:44 INFO - PROCESS | 17223 | Cycle 1(1): loaded http://localhost:55178/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55178/tests/dromaeo/cssquery-prototype.html) 04:45:44 INFO - PROCESS | 17223 | RSS: Main: 219754496 04:45:44 INFO - PROCESS | 17223 | 04:48:48 INFO - PROCESS | 17223 | Cycle 1(1): loaded http://localhost:55178/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55178/tests/dromaeo/cssquery-yui.html) 04:48:48 INFO - PROCESS | 17223 | RSS: Main: 220565504 04:48:48 INFO - PROCESS | 17223 | 04:51:51 INFO - PROCESS | 17223 | Cycle 1(1): loaded http://localhost:55178/tests/dromaeo/cssquery-yui.html (next: http://localhost:55178/tests/dromaeo/cssquery-dojo.html) 04:51:51 INFO - PROCESS | 17223 | RSS: Main: 311279616 04:51:51 INFO - PROCESS | 17223 | 04:51:51 INFO - PROCESS | 17223 | __start_tp_report 04:51:51 INFO - PROCESS | 17223 | _x_x_mozilla_page_load 04:51:51 INFO - PROCESS | 17223 | _x_x_mozilla_page_load_details 04:51:51 INFO - PROCESS | 17223 | |i|pagename|runs| 04:51:51 INFO - PROCESS | 17223 | |0;dojo.html;2499.0628514307136;2521.0294036795826;2566.6278389633503;2586.6249393837893;2601.5967525033625;4372.256716358219;4435.977820110903;4618.468876079248;4640.559146881049;4644.651651126166;4476.283794592866;4573.474050484196;4607.272272897663;4622.121796858594;4683.929741053887;4266.338717498793;4293.720908140968;4319.438472998506;4324.54592267812;4349.543297953716;4228.851990180345;4299.204647140289;4319.848805291816;4321.567843215685;4393.956060439386;4326.524082350938;4336.674749393792;4347.5652434756585;4378.8905277368;4396.230659634567;4138.13099249158;4186.6859985500905;4195.49654041517;4243.215005224012;4295.377170310318;4249.596288352602;4262.573742625744;4274.764887931163;4331.9783401083105;4343.761093139876;4648.116857797041;4649.395578574764;4658.231391820379;4673.485916549177;4685.1566717990745;4750.762461876892;4818.204996175627;4947.529984651453;4957.975210123926;4959.900801983977;4879.072976134523;4883.291922671228;4888.046830867982;4894.388201474816;4894.632902532324;4580.358749775034;4587.954120458753;4589.816407343669;4591.173588754056;4591.931121033187;4977.0792403405485;4992.525710057539;5001.474845141208;5003.724795136302;5005;4746.07451546952;4772.928406073912;4801.975990120027;4817.445993710698;4822.71063736177;4912.852614421573;4925.113479573711;4963.90072198554;4967.379077615298;4970.378702662168;4855.732934688555;4855.975720121447;4860.8298709545;4923.876903077452;4925.556699896955;4646.5353464653945;4836.12949669063;4838.782254798542;4846.903061938741;4904.4605093439695;4139.110091330378;4187.748735075845;4189.455370801777;4190.057237121684;4190.685698572619;3681.5582130144016;3687.8893633191046;3705.888823335304;3709.2025214578994;3718.0704823794053;4314.9784251078545;4318.5033721121845;4325.632321252729;4328.502222244482;4331.393604895317;4965.553100220925;4988.925166122511;4992.600591952635;4999.825006124841;5039.949600503948;4191.622753952098;4251.851185208503;4297.290946993773;4297.828086876552;4358.280883654225;4441.9333709993725;4460.30865215892;4479.7536135512855;4484.641228701696;4505.121501307213;4566.56617621332;4597.678162528591;4600.7469589172915;4608.055348653585;4660.254359302496;4938.678985865908;4956.876078097932;4970.975145124251;4974.751262436791;5030.144875371268;4496.19068567661;4520.2541580640145;4521.886952826074;4529.365888775508;4582.221022426263;4797.4482934461585;4800.879978000578;4806.447258565309;4853.077915196242;4857.611391088633;4816;4850.393700787402;4858.659893807399;4865.318855360323;4913.017396520781;4547.045120524727;4633.791479383503;4634.698744581591;4755.096531658974;4818.325434439112;4780.330753694555;4844.709317440965;4847.903041939212;4857.611391088775;4922;4768.833090841804;4815.807367705253;4816.831410900601;4816.8314109007415;4869.561739443467;4673;4895.828645997515;4907.852764417074;4915.926261106158;4968.155413579628;4624.5375462453485;4695.929561056655;4746.406699162605;4762.642801789811;4827.782749776198 04:51:51 INFO - PROCESS | 17223 | |1;ext.html;550.4907960136874;563.4168635462297;573.7389487783059;579.9884002319953;584.7251791657919;27012.729872701268;37539.62460375395;38753.41869871947;38794.61205387945;43062;38936.22127557447;39428.80285598568;39450.408243876365;39498;39542.80228598853;7523.661435235427;7676.616169191546;7677.577733224698;7678.232176782333;7681.193474685161;6087.360827113156;6090.299615544225;6221.5333849961435;6232.7506899724185;6277.121203031579;6117.1741814855095;6118.449339559439;6125.387461253884;6277.654728989904;6344.7462101515885;6077.878442431149;6077.969610151921;6081.483073938721;6083.17877086592;6236.438720515152;7534.472586918918;7586;7598.696052157962;7606.277403646644;7607.125180604246;37316.813415932746;37845.24309513822;37863.81068094642;37889.43165852514;37905.24189516222;2748.134337683643;2856.48583255014;2950.4836653585753;3039.361734035855;3443.4146195146636;28196.71803281982;28279.151625451268;28308.575371369447;28411.289717757016;28659.713402865913;3207.5349074384317;3225.2743132795167;3237.1583388318973;3289.0954987378664;3309.189248634076;239369;239534;240029;240240;240343;28889.855550722114;49286.26070608944;49525.75237123863;49565;49586.75206624016;30591.847040764653;32209.67790322067;32285.51571726426;32306.192345191088;32360.676393236237;13147.276899770604;13284.269365185008;13290.269035202964;13307.933460332637;13308.73382532344;10928.945355273332;10934.343939363664;10978.835317470244;10985.670429887115;10994;7874.173211812677;7884.448088633741;7901.249381308767;7997.560134192675;8005.839883202303;3080.553319768666;3090.7836451448634;3119.828409437457;3129.796563223383;3171.809691418522;857.7769779857282;861.4572819123912;911.832853946949;943.2029934705163;978.8874279457954;26668.19995400141;26999.125546533418;27353.86323068372;27592.586111208348;27645.86177069102;882.7131182365629;952.9666461673808;972.2416515118219;1000.4197565412044;1050.6532844161409;13721.45114195441;14216.786748198785;14414.85585144135;14453.349599268058;14469.78295325571;357581;397373;402508;403315;588990;49097.75451122721;49677.25484117669;49743;49757.50242497601;49797;1136.6249137784512;1160.6866146140494;1162.9941850290695;1166.9941650291694;1173.5423184957874;27242.182734517995;27897.34975177355;28451.857740711162;29255;29353.412931741674;40852.38721419241;41627;41656;41726;41736;313532;315111;316354;316404;316652;25026;25142.24573262805;25512.617310740727;25522.744772552036;25543.23370298894;36291.91124266276;36318.27363452663;36497.45253821248;36815.26369472542;37969.810150949066;33529.46133370321;34739;34900.47649285212;35164.12089697778;35418.64581354154;33980.49029264612;34132.31735365229;34368.82815585906;34850.651493484744;34965.30069398547;33334;33819;33909.49135762916;34560;34591.308173836886;29558.113256602337;31183.53224701586;31320.686793131776;31461.213469663442;31673.8416307917;23868.52262954766;24210;24411.75588244095;24764.25707228786;24794.25617231486 04:51:51 INFO - PROCESS | 17223 | |2;jquery.html;332.0735148934473;344.424810566354;351.3535095424419;357.07517529598334;376.6120895477657;12103.850134237244;13148.224989626398;15544.145072021034;15668.921655391736;16223.432179873707;16083.11542865142;16262.75605865913;16386.590335241595;16710.749338759928;16811.579710507245;3977.86077487288;4941.925871111936;5158.767855446514;5163.690178589297;5165.431802501722;5745.2818397700285;5967.671778052206;5977;5977.252843394575;5977.372375900533;5090.261912022755;5399.892002159974;5856.121581762727;5888.234529511179;5889.293284805808;5427.945720542803;5460.26286451328;5467.6719396836315;5470.261514695545;5471.398146203915;4432.623227025707;4682.578567928903;4721.622270218409;5287.4976877196605;5291.444398338196;11647.592334268345;11825.231359961575;11854.762904741943;11867.465964031553;11868.347240901747;1779.2704990953775;1827.8994655293955;1839.9724004139948;1881.2569035231006;1980.366282789508;8639.438436501607;9228.723138305862;9283;10470.319429237152;13132;1659.7676325314465;1687.70465168595;1717.4074944144375;1775.6892543804784;1862.6181632765386;59635;63916.68041659809;64429;64955.3504464954;71579.64210178968;9687.789026371704;9708.592254123112;9770.951145244228;9876.80246395068;10024.699259022242;13651.863481365059;13780.310984450738;13783.035187536776;13789.172649641054;13800.723985520233;6934.826629334206;6975.197852246955;7091.60996145217;7162.534435261691;7221.4583906207245;6551.976217164598;6759.3578610032955;6772.864542709118;6821;6889.173299204128;4202.159568086395;4211.599898009684;4240.151969606091;4242.703010789277;4357.716748411343;1606.3775586657327;1669.9582510437335;1767.8762486625812;1818.6089990652074;3029.6515900671266;782.6243403166512;809.3444310108831;825.7770401991548;826.1573195340719;864.4726716702932;15204.771928421083;15974.121423321829;15993.840061599467;16663.750043749355;17431.65136697259;811.4401063266328;814.9062857771314;821.5974172655475;830.8379865926087;884.8495755721543;9241.3531052827;9296.442213467213;9628.422294662343;9647.836022712565;9700.466474343837;365012;368079;369175;369623;369809;54265;70023.64751700999;71552.2844771556;72570;74138;863.6594828016022;891.3047822698176;901.2069378946616;912.3203213605906;916.0198587511433;14752.808043205809;15005.399784008518;15177.089374637557;15640.217989100727;15901.284442199898;35414.82292588521;36820.447693284084;39028.41457378085;39451.40822887602;40670.38994415027;49313;49630.75184624198;50546.49453505418;51107.488925111764;51667;7076.752313668997;7307.2327405621645;7314.451416143704;7447.47867649281;7492.138404083382;9236.815263694554;10860.511276992713;11120.777584448428;11144.442777860912;11384.950708872482;9558.8712779297;9708;9709.46597937092;9811.411315321104;10080.899191007997;10223.386596804216;10355.223358248311;10361.74095647615;10562.735931601464;10643.095336896451;9992.700218993441;10129.797404052026;10212.438315892698;10689;10722.249442538947;7386.926130738624;7509.098908130841;7539.47223694358;7543.0194074769925;7990.6004699765945;8361.623726932181;9999.200063994718;10042.648507302501;10109.696709098738;10482.109020733324 04:51:51 INFO - PROCESS | 17223 | |3;mootools.html;1346.5758286139862;1363.7545241856467;1378.4968486502423;1562.4611002952652;1584.2949887300156;6707.32926707329;7005.439564834814;7195.316444937729;7764.805879853006;7772.689092436302;7026.1217347831525;7337.88993165103;7339.155997060327;7343;7541.358984486312;2077.8337732981363;2139.251262058283;2139.7539282982425;2141.1970511058353;2142.0467891788085;1792.5966657502022;1857.1642760757645;2092.5082605587677;2108.926187583435;2124.479502521884;2020.6968954656772;2078.314156328408;2096.8951552422395;2105.6736205888037;2112.8626639268477;2099.170827523135;2106.3891471473253;2108.219958615307;2110.0926601561323;2140.529083601605;2078.324544523036;2091.979080209209;2094.2251366994155;2094.6857971304275;2099.223287383678;7404.592747398891;7568.621568921532;7574.621268936531;7588.392928565701;7592.620368981528;4363.432753741993;4475.39582156408;4478.484974227973;4489.820407183709;4497.168023915553;2690.6233127362184;2839.6592408910856;2876.6116574262624;2879.827210367385;2882.1641723900043;865.7489328094845;881.1452890696015;893.7676204186959;900.2258058070055;902.7156445719577;10245.538950747234;10503.422311772849;10509.527071281811;10513.053825155695;10515.78968420635;3800.3539398302355;3967.4048892666333;4107.958920410817;4114.855980040684;4172.520160181557;8956.731298061068;8958.731238062868;8965.775855603531;8971.50656713874;8989.10108989109;4336.111097225062;4361.433013708198;4374.8906277342685;4380.518143004267;4384.0355121873135;3941.7240793144206;3990.521137463523;3993;3995.260876737813;3997.520297564311;3428.6057103433423;3512.7892326460496;3519.472079188091;3534.6642069003406;3542.8937131886087;1084.9945750271197;1118.6644006797928;1134.1720544002924;1148.8104462763552;1151.1826603111717;570.7203470299606;690.6339639990813;758.3023618271204;761.5430741555023;772.791346336486;4735.550122738335;4761.619070474354;4830.3479030331155;4873.634477414208;4974.751262436864;766.7738017284914;793.5556088590408;793.6309616028459;847.4830353484369;853.9701110461104;3212.405704944593;3282.5240340150544;3305.8512366943546;3337.9638619604507;3349.8325083745717;8719.694810681596;9075.727728168165;9076.500792456478;9093.090690930987;9108.089191080839;9012.324075694349;9020;9022.639094436148;9042.547872606476;9062.501562413998;6746.325367463214;6935.722571097201;7015.719371225196;7066.470014748915;7071.540349877345;5052.797888084582;5125.846224613268;5163.096458119739;5201.141811601044;5396.028714831211;8163.959180204061;8388.622511986854;8595;8720.738377848675;8734.432261902955;8439.789005274917;8513.489190648581;8673.089325620971;8689.391742577958;8689.869651955352;6382.457491113121;6519.837004074936;6522.869542609026;6524.836879078061;6528.118703975093;7125;7140.750073747394;7148.714051438093;7192.712291508281;7218.530795498275;5335.653182543278;6366.713497892513;6418.229812422539;6473.643949582818;6594.208694956636;6144;6180.783672571439;6218.129461875432;6339;6370.8088757337355;5835.095560188178;5885.764569417175;5923.289205295392;5924.674142922008;5926.525877929842;4097.44684467605;4190.790460476903;4282;4328.8268469260875;4340.131973605228;4155.065110350147;4201.537830838544;4214.936775948302;4222.9577704222565;4348.739075655344 04:51:51 INFO - PROCESS | 17223 | |4;prototype.html;296.8055923370193;300.9488386974214;301.29797571658025;303.2600454890069;303.89382647164325;4788.162071637463;4862.7325497097645;4867.732274724889;4890.8043678252825;4902.5832804211595;4804.894874178941;4824.686395384298;4828.830990915319;4836.6699157731555;4843.39457567804;3583.964160358389;3705.6850167735774;3737.121776382548;3852.6917846572205;3861.150546879689;3818.179091495328;3835.047013799373;3843.830048584663;3845.4808600838946;3852.152526444178;3799.7530160539477;3807.505024346831;3809.847606095767;3815.790131542764;3818.923621527568;3587.3722098632634;3712.9257414851822;3715.8327875245677;3817.408301713239;3817.828197731109;3367.595888493372;3384.375499760129;3384.7969121852766;3385.339858727549;3406.5230867678547;4677.88305292367;4722.173619616553;4734.301448174542;4737.336772851803;4739.9526004739855;4198.538160802309;4336.91326173478;4354.281543545343;4368.17004769096;4377.7592232427205;5002.074616195979;5041.143005689041;5060.5577410437845;5074.0063362615865;5081.644284900059;3670.376036073847;3671.687906527948;3673.8897833065053;3679.9448008279896;3695.1316440636697;5321.8935621287355;5330.546903513206;5344.171653393731;5344.305240318772;5382.1657643065;3465.6014558326115;3644.21649345392;3659.38354076831;3661.377565813818;3676.264747050547;3716.9628303716618;3717.8698745543775;3722.2555488902326;3735.748524244354;3741.8503259869844;4307.483102027714;4313.835264478574;4315.719478233905;4324.372965919924;4327.156204540147;4847.2729090636685;5070.239464080344;5152.248235599914;5159.7678104485385;5162.793488260502;1330.2484096485455;1353.8443079046035;1354.7493713663005;1355.8915286777035;1362.7478916400498;843.9873401898976;880.445319448756;882.5631312500353;887.964481420736;889.8398288308038;4034.9394759078637;4065.1463192729266;4286.442762440863;4342.782860856944;4430.645548356124;5206.427292997767;5237.764300606405;5239.449857764956;5239.921401178985;5252.527272545489;4488.483824360175;4490.595846373842;4505.752183629932;4526.393130438712;4531.410916580823;2651.6930270664643;2777.47239018539;2786.1502241816443;2787.665480142396;2787.9442411152068;4904.043711476228;4905.975470122627;4915.606751459874;4922.33548470959;4942;5374.677519348852;5379.569634429236;5388.865278367994;5390.407055223922;5390.97304513475;4636.605888499448;4932.161532539477;4956.355673762388;4961;4964.67729597575;5185.533302002837;5200.375954885438;5221.190715439113;5237.7002488432045;5243.659162154448;5187.288194895751;5212.478752124757;5237.476252374732;5244.292020577326;5248.3701955765555;4703.811847526061;4916.311716359641;4939.728314942713;4960.280759289811;4968.403791545038;3705.4997575326984;3707.9629203708696;3709.870154544578;3731.9253614928093;3736.9252614947004;5281.366236051698;5318.7074710891275;5330.920036199538;5338.279332290091;5346.754363167402;4943.456219815889;5100.209467532539;5100.336956195671;5109.412417571878;5152.355955505562;5101.311322971352;5102.846914592568;5109.897802044013;5128.333316668809;5141.845744627667;5002.224655178453;5004.049230646166;5005.824796132118;5009.474005229544;5025.6482046256415;4811.446683631427;4833.139241392019;5086.982603479245;5172.405173405106;5174.818881339135;4837.7097374157665;4926.433460151985;4978.726170060537;5024.3921944977255;5032.823851165192 04:51:51 INFO - PROCESS | 17223 | |5;yui.html;590.9734061967212;642.486011191047;643.7618081309917;650.1405978900348;662.4832630548174;12661.873381266185;13053.608391748263;13472.461101555939;13522.729545409098;13987.650308742286;13793.172409655428;14457.132572045684;14458.204798736091;14608.19654918979;14610.853891461082;739.1389031777973;754.5171090502083;754.8716718157926;755.3239850333975;755.879059350504;589.6255877517764;609.3327806052365;728.6575309604477;751.8195633048084;753.9434542409314;802.2659266770897;802.6428239433454;802.743122200896;803.4978138663336;804.3002587748667;796.3191471292077;796.5738329993454;796.8645330293864;797.38202892758;797.4298376660715;461.0387342391085;469.8026828731941;561.3712641841123;573.7991702903992;590.7164561010696;12736.61790146297;12803.679908002374;12807.5517356893;12811;12824.935875320563;11738.941305293505;12135.696607584792;12261.754764904741;12299.754004919852;12802.42389092493;10788.784224315548;10973.396463194522;11482.138839586982;11645.301281923112;11803.173777835555;4056.5132184137797;4064.329385651364;4090.0605586448355;4157.438745769313;4256.616904478581;60350.094748578806;60385.99999999956;60416.39583604152;60900.695496522676;61420;9146.725598232064;9293.58178881952;9537.713868583953;9836.901630983599;9858.408495490294;16571.17144142788;16648.667026659397;16663.91668041652;16743.74884376711;16813.32746690143;6347.270063942706;6347.460465860361;6474.870502589922;6604.966975165094;6794.116764820542;3202.8078315301154;3227.177069847221;3393.4909763535175;3421.794692318469;3491.4937334086417;2791.9162425126874;2915.6792752797173;2923.254570084657;2926.6634337051087;3031.6058912341255;496.9031038947443;498.9600831933437;509.20309715295446;509.74003258338513;524.3576618642132;557.9163125531203;565.9773609055674;573.8322513684632;577.9566532509995;583.2417856786161;8031.879521807177;8053.718119865894;8180.672773089129;8347.081820999685;8521.957390213009;494.47832536674156;494.96287778416763;523.0428316181379;535.7642637239602;586.0827804485966;3555.182308069107;3607.7294202934886;3782.6973842092566;3843.9807800961376;3879.96120038796;84046.15953840506;87726;90943;90947;91012;71962;72315;74693.25306746972;75821;76281;67184.66407668029;69485.3051469489;71057.2894271061;71808.64095679489;73968.26031739614;7123.928760712327;7257.963710181415;7266.854662906818;7272.454565907684;7292.598907060163;39925;39981;40562.95777816734;41042.38436423396;41705.58294417139;50393;56905.71547142238;57350.13974790465;57632.71183644055;58071.709641451525;9646.758831029281;9862.605495780375;9871.65449209303;10056.145227655732;10079.697609071447;10843.295185813213;11067.557297708001;11201.831972520582;11259.887401126212;11370.431478426211;10242.129418999171;10390.636327728493;10808.405537695502;10810.18923580719;10860.728481788019;8181.918180818116;9662.71011869645;10589.9470502647;10694.786104278026;11129.16531260175;10901.890981090404;11018.779624407627;11086.168537359568;11116.186239561548;11764.294142351486;9184.311176661911;9421.670241541513;9812.607495700093;9852.458114803469;9909.207263419054;9676.806463870824;9764.560594773395;9766.462844543334;9886.25853061009;9912.306138570231 04:51:51 INFO - PROCESS | 17223 | __end_tp_report 04:51:51 INFO - PROCESS | 17223 | __start_cc_report 04:51:51 INFO - PROCESS | 17223 | _x_x_mozilla_cycle_collect,1303 04:51:51 INFO - PROCESS | 17223 | __end_cc_report 04:51:51 INFO - PROCESS | 17223 | __startTimestamp1476186711802__endTimestamp 04:51:51 INFO - PROCESS | 17223 | 04:51:51 INFO - PROCESS | 17223 | ------- Summary: start ------- 04:51:51 INFO - PROCESS | 17223 | Number of tests: 6 04:51:51 INFO - PROCESS | 17223 | 04:51:51 INFO - PROCESS | 17223 | [#0] dojo.html Cycles:165 Average:4555.60 Median:4646.54 stddev:465.04 (10.0%) stddev-sans-first:437.59 04:51:51 INFO - PROCESS | 17223 | Values: 2499.1 2521.0 2566.6 2586.6 2601.6 4372.3 4436.0 4618.5 4640.6 4644.7 4476.3 4573.5 4607.3 4622.1 4683.9 4266.3 4293.7 4319.4 4324.5 4349.5 4228.9 4299.2 4319.8 4321.6 4394.0 4326.5 4336.7 4347.6 4378.9 4396.2 4138.1 4186.7 4195.5 4243.2 4295.4 4249.6 4262.6 4274.8 4332.0 4343.8 4648.1 4649.4 4658.2 4673.5 4685.2 4750.8 4818.2 4947.5 4958.0 4959.9 4879.1 4883.3 4888.0 4894.4 4894.6 4580.4 4588.0 4589.8 4591.2 4591.9 4977.1 4992.5 5001.5 5003.7 5005.0 4746.1 4772.9 4802.0 4817.4 4822.7 4912.9 4925.1 4963.9 4967.4 4970.4 4855.7 4856.0 4860.8 4923.9 4925.6 4646.5 4836.1 4838.8 4846.9 4904.5 4139.1 4187.7 4189.5 4190.1 4190.7 3681.6 3687.9 3705.9 3709.2 3718.1 4315.0 4318.5 4325.6 4328.5 4331.4 4965.6 4988.9 4992.6 4999.8 5039.9 4191.6 4251.9 4297.3 4297.8 4358.3 4441.9 4460.3 4479.8 4484.6 4505.1 4566.6 4597.7 4600.7 4608.1 4660.3 4938.7 4956.9 4971.0 4974.8 5030.1 4496.2 4520.3 4521.9 4529.4 4582.2 4797.4 4800.9 4806.4 4853.1 4857.6 4816.0 4850.4 4858.7 4865.3 4913.0 4547.0 4633.8 4634.7 4755.1 4818.3 4780.3 4844.7 4847.9 4857.6 4922.0 4768.8 4815.8 4816.8 4816.8 4869.6 4673.0 4895.8 4907.9 4915.9 4968.2 4624.5 4695.9 4746.4 4762.6 4827.8 04:51:51 INFO - PROCESS | 17223 | 04:51:51 INFO - PROCESS | 17223 | [#1] ext.html Cycles:180 Average:46281.10 Median:19001.71 stddev:90549.04 (476.5%) stddev-sans-first:90737.95 04:51:51 INFO - PROCESS | 17223 | Values: 550.5 563.4 573.7 580.0 584.7 27012.7 37539.6 38753.4 38794.6 43062.0 38936.2 39428.8 39450.4 39498.0 39542.8 7523.7 7676.6 7677.6 7678.2 7681.2 6087.4 6090.3 6221.5 6232.8 6277.1 6117.2 6118.4 6125.4 6277.7 6344.7 6077.9 6078.0 6081.5 6083.2 6236.4 7534.5 7586.0 7598.7 7606.3 7607.1 37316.8 37845.2 37863.8 37889.4 37905.2 2748.1 2856.5 2950.5 3039.4 3443.4 28196.7 28279.2 28308.6 28411.3 28659.7 3207.5 3225.3 3237.2 3289.1 3309.2 239369.0 239534.0 240029.0 240240.0 240343.0 28889.9 49286.3 49525.8 49565.0 49586.8 30591.8 32209.7 32285.5 32306.2 32360.7 13147.3 13284.3 13290.3 13307.9 13308.7 10928.9 10934.3 10978.8 10985.7 10994.0 7874.2 7884.4 7901.2 7997.6 8005.8 3080.6 3090.8 3119.8 3129.8 3171.8 857.8 861.5 911.8 943.2 978.9 26668.2 26999.1 27353.9 27592.6 27645.9 882.7 953.0 972.2 1000.4 1050.7 13721.5 14216.8 14414.9 14453.3 14469.8 357581.0 397373.0 402508.0 403315.0 588990.0 49097.8 49677.3 49743.0 49757.5 49797.0 1136.6 1160.7 1163.0 1167.0 1173.5 27242.2 27897.3 28451.9 29255.0 29353.4 40852.4 41627.0 41656.0 41726.0 41736.0 313532.0 315111.0 316354.0 316404.0 316652.0 25026.0 25142.2 25512.6 25522.7 25543.2 36291.9 36318.3 36497.5 36815.3 37969.8 33529.5 34739.0 34900.5 35164.1 35418.6 33980.5 34132.3 34368.8 34850.7 34965.3 33334.0 33819.0 33909.5 34560.0 34591.3 29558.1 31183.5 31320.7 31461.2 31673.8 23868.5 24210.0 24411.8 24764.3 24794.3 04:51:51 INFO - PROCESS | 17223 | 04:51:51 INFO - PROCESS | 17223 | [#2] jquery.html Cycles:180 Average:22984.24 Median:27286.34 stddev:60758.59 (222.7%) stddev-sans-first:60905.23 04:51:51 INFO - PROCESS | 17223 | Values: 332.1 344.4 351.4 357.1 376.6 12103.9 13148.2 15544.1 15668.9 16223.4 16083.1 16262.8 16386.6 16710.7 16811.6 3977.9 4941.9 5158.8 5163.7 5165.4 5745.3 5967.7 5977.0 5977.3 5977.4 5090.3 5399.9 5856.1 5888.2 5889.3 5427.9 5460.3 5467.7 5470.3 5471.4 4432.6 4682.6 4721.6 5287.5 5291.4 11647.6 11825.2 11854.8 11867.5 11868.3 1779.3 1827.9 1840.0 1881.3 1980.4 8639.4 9228.7 9283.0 10470.3 13132.0 1659.8 1687.7 1717.4 1775.7 1862.6 59635.0 63916.7 64429.0 64955.4 71579.6 9687.8 9708.6 9771.0 9876.8 10024.7 13651.9 13780.3 13783.0 13789.2 13800.7 6934.8 6975.2 7091.6 7162.5 7221.5 6552.0 6759.4 6772.9 6821.0 6889.2 4202.2 4211.6 4240.2 4242.7 4357.7 1606.4 1670.0 1767.9 1818.6 3029.7 782.6 809.3 825.8 826.2 864.5 15204.8 15974.1 15993.8 16663.8 17431.7 811.4 814.9 821.6 830.8 884.8 9241.4 9296.4 9628.4 9647.8 9700.5 365012.0 368079.0 369175.0 369623.0 369809.0 54265.0 70023.6 71552.3 72570.0 74138.0 863.7 891.3 901.2 912.3 916.0 14752.8 15005.4 15177.1 15640.2 15901.3 35414.8 36820.4 39028.4 39451.4 40670.4 49313.0 49630.8 50546.5 51107.5 51667.0 7076.8 7307.2 7314.5 7447.5 7492.1 9236.8 10860.5 11120.8 11144.4 11385.0 9558.9 9708.0 9709.5 9811.4 10080.9 10223.4 10355.2 10361.7 10562.7 10643.1 9992.7 10129.8 10212.4 10689.0 10722.2 7386.9 7509.1 7539.5 7543.0 7990.6 8361.6 9999.2 10042.6 10109.7 10482.1 04:51:51 INFO - PROCESS | 17223 | 04:51:51 INFO - PROCESS | 17223 | [#3] mootools.html Cycles:180 Average:4892.80 Median:5089.32 stddev:2756.58 (54.2%) stddev-sans-first:2751.43 04:51:51 INFO - PROCESS | 17223 | Values: 1346.6 1363.8 1378.5 1562.5 1584.3 6707.3 7005.4 7195.3 7764.8 7772.7 7026.1 7337.9 7339.2 7343.0 7541.4 2077.8 2139.3 2139.8 2141.2 2142.0 1792.6 1857.2 2092.5 2108.9 2124.5 2020.7 2078.3 2096.9 2105.7 2112.9 2099.2 2106.4 2108.2 2110.1 2140.5 2078.3 2092.0 2094.2 2094.7 2099.2 7404.6 7568.6 7574.6 7588.4 7592.6 4363.4 4475.4 4478.5 4489.8 4497.2 2690.6 2839.7 2876.6 2879.8 2882.2 865.7 881.1 893.8 900.2 902.7 10245.5 10503.4 10509.5 10513.1 10515.8 3800.4 3967.4 4108.0 4114.9 4172.5 8956.7 8958.7 8965.8 8971.5 8989.1 4336.1 4361.4 4374.9 4380.5 4384.0 3941.7 3990.5 3993.0 3995.3 3997.5 3428.6 3512.8 3519.5 3534.7 3542.9 1085.0 1118.7 1134.2 1148.8 1151.2 570.7 690.6 758.3 761.5 772.8 4735.6 4761.6 4830.3 4873.6 4974.8 766.8 793.6 793.6 847.5 854.0 3212.4 3282.5 3305.9 3338.0 3349.8 8719.7 9075.7 9076.5 9093.1 9108.1 9012.3 9020.0 9022.6 9042.5 9062.5 6746.3 6935.7 7015.7 7066.5 7071.5 5052.8 5125.8 5163.1 5201.1 5396.0 8164.0 8388.6 8595.0 8720.7 8734.4 8439.8 8513.5 8673.1 8689.4 8689.9 6382.5 6519.8 6522.9 6524.8 6528.1 7125.0 7140.8 7148.7 7192.7 7218.5 5335.7 6366.7 6418.2 6473.6 6594.2 6144.0 6180.8 6218.1 6339.0 6370.8 5835.1 5885.8 5923.3 5924.7 5926.5 4097.4 4190.8 4282.0 4328.8 4340.1 4155.1 4201.5 4214.9 4223.0 4348.7 04:51:51 INFO - PROCESS | 17223 | 04:51:51 INFO - PROCESS | 17223 | [#4] prototype.html Cycles:180 Average:4224.86 Median:4826.76 stddev:1226.39 (25.4%) stddev-sans-first:1193.87 04:51:51 INFO - PROCESS | 17223 | Values: 296.8 300.9 301.3 303.3 303.9 4788.2 4862.7 4867.7 4890.8 4902.6 4804.9 4824.7 4828.8 4836.7 4843.4 3584.0 3705.7 3737.1 3852.7 3861.2 3818.2 3835.0 3843.8 3845.5 3852.2 3799.8 3807.5 3809.8 3815.8 3818.9 3587.4 3712.9 3715.8 3817.4 3817.8 3367.6 3384.4 3384.8 3385.3 3406.5 4677.9 4722.2 4734.3 4737.3 4740.0 4198.5 4336.9 4354.3 4368.2 4377.8 5002.1 5041.1 5060.6 5074.0 5081.6 3670.4 3671.7 3673.9 3679.9 3695.1 5321.9 5330.5 5344.2 5344.3 5382.2 3465.6 3644.2 3659.4 3661.4 3676.3 3717.0 3717.9 3722.3 3735.7 3741.9 4307.5 4313.8 4315.7 4324.4 4327.2 4847.3 5070.2 5152.2 5159.8 5162.8 1330.2 1353.8 1354.7 1355.9 1362.7 844.0 880.4 882.6 888.0 889.8 4034.9 4065.1 4286.4 4342.8 4430.6 5206.4 5237.8 5239.4 5239.9 5252.5 4488.5 4490.6 4505.8 4526.4 4531.4 2651.7 2777.5 2786.2 2787.7 2787.9 4904.0 4906.0 4915.6 4922.3 4942.0 5374.7 5379.6 5388.9 5390.4 5391.0 4636.6 4932.2 4956.4 4961.0 4964.7 5185.5 5200.4 5221.2 5237.7 5243.7 5187.3 5212.5 5237.5 5244.3 5248.4 4703.8 4916.3 4939.7 4960.3 4968.4 3705.5 3708.0 3709.9 3731.9 3736.9 5281.4 5318.7 5330.9 5338.3 5346.8 4943.5 5100.2 5100.3 5109.4 5152.4 5101.3 5102.8 5109.9 5128.3 5141.8 5002.2 5004.0 5005.8 5009.5 5025.6 4811.4 4833.1 5087.0 5172.4 5174.8 4837.7 4926.4 4978.7 5024.4 5032.8 04:51:51 INFO - PROCESS | 17223 | 04:51:51 INFO - PROCESS | 17223 | [#5] yui.html Cycles:180 Average:16551.47 Median:28739.76 stddev:23172.85 (80.6%) stddev-sans-first:23206.86 04:51:51 INFO - PROCESS | 17223 | Values: 591.0 642.5 643.8 650.1 662.5 12661.9 13053.6 13472.5 13522.7 13987.7 13793.2 14457.1 14458.2 14608.2 14610.9 739.1 754.5 754.9 755.3 755.9 589.6 609.3 728.7 751.8 753.9 802.3 802.6 802.7 803.5 804.3 796.3 796.6 796.9 797.4 797.4 461.0 469.8 561.4 573.8 590.7 12736.6 12803.7 12807.6 12811.0 12824.9 11738.9 12135.7 12261.8 12299.8 12802.4 10788.8 10973.4 11482.1 11645.3 11803.2 4056.5 4064.3 4090.1 4157.4 4256.6 60350.1 60386.0 60416.4 60900.7 61420.0 9146.7 9293.6 9537.7 9836.9 9858.4 16571.2 16648.7 16663.9 16743.7 16813.3 6347.3 6347.5 6474.9 6605.0 6794.1 3202.8 3227.2 3393.5 3421.8 3491.5 2791.9 2915.7 2923.3 2926.7 3031.6 496.9 499.0 509.2 509.7 524.4 557.9 566.0 573.8 578.0 583.2 8031.9 8053.7 8180.7 8347.1 8522.0 494.5 495.0 523.0 535.8 586.1 3555.2 3607.7 3782.7 3844.0 3880.0 84046.2 87726.0 90943.0 90947.0 91012.0 71962.0 72315.0 74693.3 75821.0 76281.0 67184.7 69485.3 71057.3 71808.6 73968.3 7123.9 7258.0 7266.9 7272.5 7292.6 39925.0 39981.0 40563.0 41042.4 41705.6 50393.0 56905.7 57350.1 57632.7 58071.7 9646.8 9862.6 9871.7 10056.1 10079.7 10843.3 11067.6 11201.8 11259.9 11370.4 10242.1 10390.6 10808.4 10810.2 10860.7 8181.9 9662.7 10589.9 10694.8 11129.2 10901.9 11018.8 11086.2 11116.2 11764.3 9184.3 9421.7 9812.6 9852.5 9909.2 9676.8 9764.6 9766.5 9886.3 9912.3 04:51:51 INFO - PROCESS | 17223 | -------- Summary: end -------- 04:51:51 INFO - PROCESS | 17223 | 04:51:52 INFO - TEST-INFO | 17223: exit 0 04:51:52 INFO - TEST-OK | dromaeo_css | took 1122258ms 04:51:52 INFO - TEST-START | kraken 04:51:52 INFO - operating with platform_type : linux_ 04:51:52 INFO - Initialising browser for kraken test... 04:51:52 INFO - TEST-INFO | started process 17530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph17vi0/profile http://localhost:55178/getInfo.html) 04:51:57 INFO - PROCESS | 17530 | __metrics Screen width/height:1600/1200 04:51:57 INFO - PROCESS | 17530 | colorDepth:24 04:51:57 INFO - PROCESS | 17530 | Browser inner width/height: 1024/697 04:51:57 INFO - PROCESS | 17530 | __metrics 04:51:57 INFO - PROCESS | 17530 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:51:57 INFO - PROCESS | 17530 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:58 INFO - PROCESS | 17530 | console.error: PushService: 04:51:58 INFO - PROCESS | 17530 | stateChangeProcessEnqueue: Error transitioning state 04:51:58 INFO - PROCESS | 17530 | UnknownError 04:51:59 INFO - TEST-INFO | 17530: exit 0 04:51:59 INFO - Browser initialized. 04:51:59 INFO - Running cycle 1/1 for kraken test... 04:51:59 INFO - TEST-INFO | started process 17615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph17vi0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:11 INFO - PROCESS | 17615 | RSS: Main: 174526464 04:52:11 INFO - PROCESS | 17615 | 04:52:14 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55178/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:15 INFO - PROCESS | 17615 | RSS: Main: 236998656 04:52:15 INFO - PROCESS | 17615 | 04:52:18 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55178/tests/kraken/driver.html?testName=audio-dft) 04:52:18 INFO - PROCESS | 17615 | RSS: Main: 218320896 04:52:18 INFO - PROCESS | 17615 | 04:52:21 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55178/tests/kraken/driver.html?testName=audio-fft) 04:52:22 INFO - PROCESS | 17615 | RSS: Main: 300064768 04:52:22 INFO - PROCESS | 17615 | 04:52:24 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55178/tests/kraken/driver.html?testName=audio-oscillator) 04:52:25 INFO - PROCESS | 17615 | RSS: Main: 210788352 04:52:25 INFO - PROCESS | 17615 | 04:52:27 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55178/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:28 INFO - PROCESS | 17615 | RSS: Main: 213217280 04:52:28 INFO - PROCESS | 17615 | 04:52:31 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55178/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:32 INFO - PROCESS | 17615 | RSS: Main: 250048512 04:52:32 INFO - PROCESS | 17615 | 04:52:35 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55178/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:36 INFO - PROCESS | 17615 | RSS: Main: 243339264 04:52:36 INFO - PROCESS | 17615 | 04:52:39 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55178/tests/kraken/driver.html?testName=json-parse-financial) 04:52:39 INFO - PROCESS | 17615 | RSS: Main: 246329344 04:52:39 INFO - PROCESS | 17615 | 04:52:41 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55178/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:41 INFO - PROCESS | 17615 | RSS: Main: 209829888 04:52:41 INFO - PROCESS | 17615 | 04:52:43 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55178/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:44 INFO - PROCESS | 17615 | RSS: Main: 216891392 04:52:44 INFO - PROCESS | 17615 | 04:52:46 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55178/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:47 INFO - PROCESS | 17615 | RSS: Main: 226254848 04:52:47 INFO - PROCESS | 17615 | 04:52:50 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55178/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:50 INFO - PROCESS | 17615 | RSS: Main: 234446848 04:52:50 INFO - PROCESS | 17615 | 04:52:53 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55178/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:54 INFO - PROCESS | 17615 | RSS: Main: 232112128 04:52:54 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | Cycle 1(1): loaded http://localhost:55178/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55178/tests/kraken/driver.html?testName=ai-astar) 04:52:56 INFO - PROCESS | 17615 | RSS: Main: 282939392 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | __start_tp_report 04:52:56 INFO - PROCESS | 17615 | _x_x_mozilla_page_load 04:52:56 INFO - PROCESS | 17615 | _x_x_mozilla_page_load_details 04:52:56 INFO - PROCESS | 17615 | |i|pagename|runs| 04:52:56 INFO - PROCESS | 17615 | |0;ai-astar;112;117;113;116;115;115;116;115;115;115 04:52:56 INFO - PROCESS | 17615 | |1;audio-beat-detection;151;129;124;163;128;126;132;131;164;131 04:52:56 INFO - PROCESS | 17615 | |2;audio-dft;162;161;161;163;161;161;163;163;161;162 04:52:56 INFO - PROCESS | 17615 | |3;audio-fft;74;75;75;107;77;77;76;76;106;75 04:52:56 INFO - PROCESS | 17615 | |4;audio-oscillator;83;83;120;82;83;84;112;84;82;124 04:52:56 INFO - PROCESS | 17615 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;118;116;117 04:52:56 INFO - PROCESS | 17615 | |6;imaging-darkroom;148;146;146;146;146;147;146;146;146;146 04:52:56 INFO - PROCESS | 17615 | |7;imaging-desaturate;95;96;95;96;96;95;95;95;97;96 04:52:56 INFO - PROCESS | 17615 | |8;json-parse-financial;66;64;64;63;64;66;66;64;64;65 04:52:56 INFO - PROCESS | 17615 | |9;json-stringify-tinderbox;65;65;64;65;67;66;65;65;65;67 04:52:56 INFO - PROCESS | 17615 | |10;stanford-crypto-aes;84;83;85;83;83;82;86;82;88;83 04:52:56 INFO - PROCESS | 17615 | |11;stanford-crypto-ccm;141;148;138;147;140;139;149;140;177;141 04:52:56 INFO - PROCESS | 17615 | |12;stanford-crypto-pbkdf2;180;177;180;174;178;175;178;180;174;172 04:52:56 INFO - PROCESS | 17615 | |13;stanford-crypto-sha256-iterative;68;70;75;74;74;71;70;74;69;67 04:52:56 INFO - PROCESS | 17615 | __end_tp_report 04:52:56 INFO - PROCESS | 17615 | __start_cc_report 04:52:56 INFO - PROCESS | 17615 | _x_x_mozilla_cycle_collect,1984 04:52:56 INFO - PROCESS | 17615 | __end_cc_report 04:52:56 INFO - PROCESS | 17615 | __startTimestamp1476186776517__endTimestamp 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | ------- Summary: start ------- 04:52:56 INFO - PROCESS | 17615 | Number of tests: 14 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:1.45 (1.3%) stddev-sans-first:1.09 04:52:56 INFO - PROCESS | 17615 | Values: 112.0 117.0 113.0 116.0 115.0 115.0 116.0 115.0 115.0 115.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:131.50 stddev:15.37 (11.7%) stddev-sans-first:15.55 04:52:56 INFO - PROCESS | 17615 | Values: 151.0 129.0 124.0 163.0 128.0 126.0 132.0 131.0 164.0 131.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 04:52:56 INFO - PROCESS | 17615 | Values: 162.0 161.0 161.0 163.0 161.0 161.0 163.0 163.0 161.0 162.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:13.05 (17.3%) stddev-sans-first:13.54 04:52:56 INFO - PROCESS | 17615 | Values: 74.0 75.0 75.0 107.0 77.0 77.0 76.0 76.0 106.0 75.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:83.00 stddev:17.48 (21.1%) stddev-sans-first:18.11 04:52:56 INFO - PROCESS | 17615 | Values: 83.0 83.0 120.0 82.0 83.0 84.0 112.0 84.0 82.0 124.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:52:56 INFO - PROCESS | 17615 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 117.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.33 04:52:56 INFO - PROCESS | 17615 | Values: 148.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 04:52:56 INFO - PROCESS | 17615 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 97.0 96.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.50 stddev:1.07 (1.7%) stddev-sans-first:1.01 04:52:56 INFO - PROCESS | 17615 | Values: 66.0 64.0 64.0 63.0 64.0 66.0 66.0 64.0 64.0 65.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 04:52:56 INFO - PROCESS | 17615 | Values: 65.0 65.0 64.0 65.0 67.0 66.0 65.0 65.0 65.0 67.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:1.91 (2.3%) stddev-sans-first:2.03 04:52:56 INFO - PROCESS | 17615 | Values: 84.0 83.0 85.0 83.0 83.0 82.0 86.0 82.0 88.0 83.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:144.00 stddev:11.60 (8.1%) stddev-sans-first:12.16 04:52:56 INFO - PROCESS | 17615 | Values: 141.0 148.0 138.0 147.0 140.0 139.0 149.0 140.0 177.0 141.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:178.00 stddev:2.90 (1.6%) stddev-sans-first:2.83 04:52:56 INFO - PROCESS | 17615 | Values: 180.0 177.0 180.0 174.0 178.0 175.0 178.0 180.0 174.0 172.0 04:52:56 INFO - PROCESS | 17615 | 04:52:56 INFO - PROCESS | 17615 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:72.50 stddev:2.86 (3.9%) stddev-sans-first:2.79 04:52:56 INFO - PROCESS | 17615 | Values: 68.0 70.0 75.0 74.0 74.0 71.0 70.0 74.0 69.0 67.0 04:52:56 INFO - PROCESS | 17615 | -------- Summary: end -------- 04:52:56 INFO - PROCESS | 17615 | 04:52:57 INFO - TEST-INFO | 17615: exit 0 04:52:57 INFO - TEST-OK | kraken | took 64996ms 04:52:57 INFO - SUITE-END | took 1187s 04:52:58 INFO - Completed test suite (00:19:47) 04:52:58 INFO - javascript benchmark 04:52:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2499.0628514307136, 2521.0294036795826, 2566.6278389633503, 2586.6249393837893, 2601.5967525033625, 4372.256716358219, 4435.977820110903, 4618.468876079248, 4640.559146881049, 4644.651651126166, 4476.283794592866, 4573.474050484196, 4607.272272897663, 4622.121796858594, 4683.929741053887, 4266.338717498793, 4293.720908140968, 4319.438472998506, 4324.54592267812, 4349.543297953716, 4228.851990180345, 4299.204647140289, 4319.848805291816, 4321.567843215685, 4393.956060439386, 4326.524082350938, 4336.674749393792, 4347.5652434756585, 4378.8905277368, 4396.230659634567, 4138.13099249158, 4186.6859985500905, 4195.49654041517, 4243.215005224012, 4295.377170310318, 4249.596288352602, 4262.573742625744, 4274.764887931163, 4331.9783401083105, 4343.761093139876, 4648.116857797041, 4649.395578574764, 4658.231391820379, 4673.485916549177, 4685.1566717990745, 4750.762461876892, 4818.204996175627, 4947.529984651453, 4957.975210123926, 4959.900801983977, 4879.072976134523, 4883.291922671228, 4888.046830867982, 4894.388201474816, 4894.632902532324, 4580.358749775034, 4587.954120458753, 4589.816407343669, 4591.173588754056, 4591.931121033187, 4977.0792403405485, 4992.525710057539, 5001.474845141208, 5003.724795136302, 5005.0, 4746.07451546952, 4772.928406073912, 4801.975990120027, 4817.445993710698, 4822.71063736177, 4912.852614421573, 4925.113479573711, 4963.90072198554, 4967.379077615298, 4970.378702662168, 4855.732934688555, 4855.975720121447, 4860.8298709545, 4923.876903077452, 4925.556699896955, 4646.5353464653945, 4836.12949669063, 4838.782254798542, 4846.903061938741, 4904.4605093439695, 4139.110091330378, 4187.748735075845, 4189.455370801777, 4190.057237121684, 4190.685698572619, 3681.5582130144016, 3687.8893633191046, 3705.888823335304, 3709.2025214578994, 3718.0704823794053, 4314.9784251078545, 4318.5033721121845, 4325.632321252729, 4328.502222244482, 4331.393604895317, 4965.553100220925, 4988.925166122511, 4992.600591952635, 4999.825006124841, 5039.949600503948, 4191.622753952098, 4251.851185208503, 4297.290946993773, 4297.828086876552, 4358.280883654225, 4441.9333709993725, 4460.30865215892, 4479.7536135512855, 4484.641228701696, 4505.121501307213, 4566.56617621332, 4597.678162528591, 4600.7469589172915, 4608.055348653585, 4660.254359302496, 4938.678985865908, 4956.876078097932, 4970.975145124251, 4974.751262436791, 5030.144875371268, 4496.19068567661, 4520.2541580640145, 4521.886952826074, 4529.365888775508, 4582.221022426263, 4797.4482934461585, 4800.879978000578, 4806.447258565309, 4853.077915196242, 4857.611391088633, 4816.0, 4850.393700787402, 4858.659893807399, 4865.318855360323, 4913.017396520781, 4547.045120524727, 4633.791479383503, 4634.698744581591, 4755.096531658974, 4818.325434439112, 4780.330753694555, 4844.709317440965, 4847.903041939212, 4857.611391088775, 4922.0, 4768.833090841804, 4815.807367705253, 4816.831410900601, 4816.8314109007415, 4869.561739443467, 4673.0, 4895.828645997515, 4907.852764417074, 4915.926261106158, 4968.155413579628, 4624.5375462453485, 4695.929561056655, 4746.406699162605, 4762.642801789811, 4827.782749776198], "value": 4526.3051645645055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4907960136874, 563.4168635462297, 573.7389487783059, 579.9884002319953, 584.7251791657919, 27012.729872701268, 37539.62460375395, 38753.41869871947, 38794.61205387945, 43062.0, 38936.22127557447, 39428.80285598568, 39450.408243876365, 39498.0, 39542.80228598853, 7523.661435235427, 7676.616169191546, 7677.577733224698, 7678.232176782333, 7681.193474685161, 6087.360827113156, 6090.299615544225, 6221.5333849961435, 6232.7506899724185, 6277.121203031579, 6117.1741814855095, 6118.449339559439, 6125.387461253884, 6277.654728989904, 6344.7462101515885, 6077.878442431149, 6077.969610151921, 6081.483073938721, 6083.17877086592, 6236.438720515152, 7534.472586918918, 7586.0, 7598.696052157962, 7606.277403646644, 7607.125180604246, 37316.813415932746, 37845.24309513822, 37863.81068094642, 37889.43165852514, 37905.24189516222, 2748.134337683643, 2856.48583255014, 2950.4836653585753, 3039.361734035855, 3443.4146195146636, 28196.71803281982, 28279.151625451268, 28308.575371369447, 28411.289717757016, 28659.713402865913, 3207.5349074384317, 3225.2743132795167, 3237.1583388318973, 3289.0954987378664, 3309.189248634076, 239369.0, 239534.0, 240029.0, 240240.0, 240343.0, 28889.855550722114, 49286.26070608944, 49525.75237123863, 49565.0, 49586.75206624016, 30591.847040764653, 32209.67790322067, 32285.51571726426, 32306.192345191088, 32360.676393236237, 13147.276899770604, 13284.269365185008, 13290.269035202964, 13307.933460332637, 13308.73382532344, 10928.945355273332, 10934.343939363664, 10978.835317470244, 10985.670429887115, 10994.0, 7874.173211812677, 7884.448088633741, 7901.249381308767, 7997.560134192675, 8005.839883202303, 3080.553319768666, 3090.7836451448634, 3119.828409437457, 3129.796563223383, 3171.809691418522, 857.7769779857282, 861.4572819123912, 911.832853946949, 943.2029934705163, 978.8874279457954, 26668.19995400141, 26999.125546533418, 27353.86323068372, 27592.586111208348, 27645.86177069102, 882.7131182365629, 952.9666461673808, 972.2416515118219, 1000.4197565412044, 1050.6532844161409, 13721.45114195441, 14216.786748198785, 14414.85585144135, 14453.349599268058, 14469.78295325571, 357581.0, 397373.0, 402508.0, 403315.0, 588990.0, 49097.75451122721, 49677.25484117669, 49743.0, 49757.50242497601, 49797.0, 1136.6249137784512, 1160.6866146140494, 1162.9941850290695, 1166.9941650291694, 1173.5423184957874, 27242.182734517995, 27897.34975177355, 28451.857740711162, 29255.0, 29353.412931741674, 40852.38721419241, 41627.0, 41656.0, 41726.0, 41736.0, 313532.0, 315111.0, 316354.0, 316404.0, 316652.0, 25026.0, 25142.24573262805, 25512.617310740727, 25522.744772552036, 25543.23370298894, 36291.91124266276, 36318.27363452663, 36497.45253821248, 36815.26369472542, 37969.810150949066, 33529.46133370321, 34739.0, 34900.47649285212, 35164.12089697778, 35418.64581354154, 33980.49029264612, 34132.31735365229, 34368.82815585906, 34850.651493484744, 34965.30069398547, 33334.0, 33819.0, 33909.49135762916, 34560.0, 34591.308173836886, 29558.113256602337, 31183.53224701586, 31320.686793131776, 31461.213469663442, 31673.8416307917, 23868.52262954766, 24210.0, 24411.75588244095, 24764.25707228786, 24794.25617231486], "value": 15781.822358726331, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.0735148934473, 344.424810566354, 351.3535095424419, 357.07517529598334, 376.6120895477657, 12103.850134237244, 13148.224989626398, 15544.145072021034, 15668.921655391736, 16223.432179873707, 16083.11542865142, 16262.75605865913, 16386.590335241595, 16710.749338759928, 16811.579710507245, 3977.86077487288, 4941.925871111936, 5158.767855446514, 5163.690178589297, 5165.431802501722, 5745.2818397700285, 5967.671778052206, 5977.0, 5977.252843394575, 5977.372375900533, 5090.261912022755, 5399.892002159974, 5856.121581762727, 5888.234529511179, 5889.293284805808, 5427.945720542803, 5460.26286451328, 5467.6719396836315, 5470.261514695545, 5471.398146203915, 4432.623227025707, 4682.578567928903, 4721.622270218409, 5287.4976877196605, 5291.444398338196, 11647.592334268345, 11825.231359961575, 11854.762904741943, 11867.465964031553, 11868.347240901747, 1779.2704990953775, 1827.8994655293955, 1839.9724004139948, 1881.2569035231006, 1980.366282789508, 8639.438436501607, 9228.723138305862, 9283.0, 10470.319429237152, 13132.0, 1659.7676325314465, 1687.70465168595, 1717.4074944144375, 1775.6892543804784, 1862.6181632765386, 59635.0, 63916.68041659809, 64429.0, 64955.3504464954, 71579.64210178968, 9687.789026371704, 9708.592254123112, 9770.951145244228, 9876.80246395068, 10024.699259022242, 13651.863481365059, 13780.310984450738, 13783.035187536776, 13789.172649641054, 13800.723985520233, 6934.826629334206, 6975.197852246955, 7091.60996145217, 7162.534435261691, 7221.4583906207245, 6551.976217164598, 6759.3578610032955, 6772.864542709118, 6821.0, 6889.173299204128, 4202.159568086395, 4211.599898009684, 4240.151969606091, 4242.703010789277, 4357.716748411343, 1606.3775586657327, 1669.9582510437335, 1767.8762486625812, 1818.6089990652074, 3029.6515900671266, 782.6243403166512, 809.3444310108831, 825.7770401991548, 826.1573195340719, 864.4726716702932, 15204.771928421083, 15974.121423321829, 15993.840061599467, 16663.750043749355, 17431.65136697259, 811.4401063266328, 814.9062857771314, 821.5974172655475, 830.8379865926087, 884.8495755721543, 9241.3531052827, 9296.442213467213, 9628.422294662343, 9647.836022712565, 9700.466474343837, 365012.0, 368079.0, 369175.0, 369623.0, 369809.0, 54265.0, 70023.64751700999, 71552.2844771556, 72570.0, 74138.0, 863.6594828016022, 891.3047822698176, 901.2069378946616, 912.3203213605906, 916.0198587511433, 14752.808043205809, 15005.399784008518, 15177.089374637557, 15640.217989100727, 15901.284442199898, 35414.82292588521, 36820.447693284084, 39028.41457378085, 39451.40822887602, 40670.38994415027, 49313.0, 49630.75184624198, 50546.49453505418, 51107.488925111764, 51667.0, 7076.752313668997, 7307.2327405621645, 7314.451416143704, 7447.47867649281, 7492.138404083382, 9236.815263694554, 10860.511276992713, 11120.777584448428, 11144.442777860912, 11384.950708872482, 9558.8712779297, 9708.0, 9709.46597937092, 9811.411315321104, 10080.899191007997, 10223.386596804216, 10355.223358248311, 10361.74095647615, 10562.735931601464, 10643.095336896451, 9992.700218993441, 10129.797404052026, 10212.438315892698, 10689.0, 10722.249442538947, 7386.926130738624, 7509.098908130841, 7539.47223694358, 7543.0194074769925, 7990.6004699765945, 8361.623726932181, 9999.200063994718, 10042.648507302501, 10109.696709098738, 10482.109020733324], "value": 7914.390491980748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.5758286139862, 1363.7545241856467, 1378.4968486502423, 1562.4611002952652, 1584.2949887300156, 6707.32926707329, 7005.439564834814, 7195.316444937729, 7764.805879853006, 7772.689092436302, 7026.1217347831525, 7337.88993165103, 7339.155997060327, 7343.0, 7541.358984486312, 2077.8337732981363, 2139.251262058283, 2139.7539282982425, 2141.1970511058353, 2142.0467891788085, 1792.5966657502022, 1857.1642760757645, 2092.5082605587677, 2108.926187583435, 2124.479502521884, 2020.6968954656772, 2078.314156328408, 2096.8951552422395, 2105.6736205888037, 2112.8626639268477, 2099.170827523135, 2106.3891471473253, 2108.219958615307, 2110.0926601561323, 2140.529083601605, 2078.324544523036, 2091.979080209209, 2094.2251366994155, 2094.6857971304275, 2099.223287383678, 7404.592747398891, 7568.621568921532, 7574.621268936531, 7588.392928565701, 7592.620368981528, 4363.432753741993, 4475.39582156408, 4478.484974227973, 4489.820407183709, 4497.168023915553, 2690.6233127362184, 2839.6592408910856, 2876.6116574262624, 2879.827210367385, 2882.1641723900043, 865.7489328094845, 881.1452890696015, 893.7676204186959, 900.2258058070055, 902.7156445719577, 10245.538950747234, 10503.422311772849, 10509.527071281811, 10513.053825155695, 10515.78968420635, 3800.3539398302355, 3967.4048892666333, 4107.958920410817, 4114.855980040684, 4172.520160181557, 8956.731298061068, 8958.731238062868, 8965.775855603531, 8971.50656713874, 8989.10108989109, 4336.111097225062, 4361.433013708198, 4374.8906277342685, 4380.518143004267, 4384.0355121873135, 3941.7240793144206, 3990.521137463523, 3993.0, 3995.260876737813, 3997.520297564311, 3428.6057103433423, 3512.7892326460496, 3519.472079188091, 3534.6642069003406, 3542.8937131886087, 1084.9945750271197, 1118.6644006797928, 1134.1720544002924, 1148.8104462763552, 1151.1826603111717, 570.7203470299606, 690.6339639990813, 758.3023618271204, 761.5430741555023, 772.791346336486, 4735.550122738335, 4761.619070474354, 4830.3479030331155, 4873.634477414208, 4974.751262436864, 766.7738017284914, 793.5556088590408, 793.6309616028459, 847.4830353484369, 853.9701110461104, 3212.405704944593, 3282.5240340150544, 3305.8512366943546, 3337.9638619604507, 3349.8325083745717, 8719.694810681596, 9075.727728168165, 9076.500792456478, 9093.090690930987, 9108.089191080839, 9012.324075694349, 9020.0, 9022.639094436148, 9042.547872606476, 9062.501562413998, 6746.325367463214, 6935.722571097201, 7015.719371225196, 7066.470014748915, 7071.540349877345, 5052.797888084582, 5125.846224613268, 5163.096458119739, 5201.141811601044, 5396.028714831211, 8163.959180204061, 8388.622511986854, 8595.0, 8720.738377848675, 8734.432261902955, 8439.789005274917, 8513.489190648581, 8673.089325620971, 8689.391742577958, 8689.869651955352, 6382.457491113121, 6519.837004074936, 6522.869542609026, 6524.836879078061, 6528.118703975093, 7125.0, 7140.750073747394, 7148.714051438093, 7192.712291508281, 7218.530795498275, 5335.653182543278, 6366.713497892513, 6418.229812422539, 6473.643949582818, 6594.208694956636, 6144.0, 6180.783672571439, 6218.129461875432, 6339.0, 6370.8088757337355, 5835.095560188178, 5885.764569417175, 5923.289205295392, 5924.674142922008, 5926.525877929842, 4097.44684467605, 4190.790460476903, 4282.0, 4328.8268469260875, 4340.131973605228, 4155.065110350147, 4201.537830838544, 4214.936775948302, 4222.9577704222565, 4348.739075655344], "value": 3931.9257201240284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.8055923370193, 300.9488386974214, 301.29797571658025, 303.2600454890069, 303.89382647164325, 4788.162071637463, 4862.7325497097645, 4867.732274724889, 4890.8043678252825, 4902.5832804211595, 4804.894874178941, 4824.686395384298, 4828.830990915319, 4836.6699157731555, 4843.39457567804, 3583.964160358389, 3705.6850167735774, 3737.121776382548, 3852.6917846572205, 3861.150546879689, 3818.179091495328, 3835.047013799373, 3843.830048584663, 3845.4808600838946, 3852.152526444178, 3799.7530160539477, 3807.505024346831, 3809.847606095767, 3815.790131542764, 3818.923621527568, 3587.3722098632634, 3712.9257414851822, 3715.8327875245677, 3817.408301713239, 3817.828197731109, 3367.595888493372, 3384.375499760129, 3384.7969121852766, 3385.339858727549, 3406.5230867678547, 4677.88305292367, 4722.173619616553, 4734.301448174542, 4737.336772851803, 4739.9526004739855, 4198.538160802309, 4336.91326173478, 4354.281543545343, 4368.17004769096, 4377.7592232427205, 5002.074616195979, 5041.143005689041, 5060.5577410437845, 5074.0063362615865, 5081.644284900059, 3670.376036073847, 3671.687906527948, 3673.8897833065053, 3679.9448008279896, 3695.1316440636697, 5321.8935621287355, 5330.546903513206, 5344.171653393731, 5344.305240318772, 5382.1657643065, 3465.6014558326115, 3644.21649345392, 3659.38354076831, 3661.377565813818, 3676.264747050547, 3716.9628303716618, 3717.8698745543775, 3722.2555488902326, 3735.748524244354, 3741.8503259869844, 4307.483102027714, 4313.835264478574, 4315.719478233905, 4324.372965919924, 4327.156204540147, 4847.2729090636685, 5070.239464080344, 5152.248235599914, 5159.7678104485385, 5162.793488260502, 1330.2484096485455, 1353.8443079046035, 1354.7493713663005, 1355.8915286777035, 1362.7478916400498, 843.9873401898976, 880.445319448756, 882.5631312500353, 887.964481420736, 889.8398288308038, 4034.9394759078637, 4065.1463192729266, 4286.442762440863, 4342.782860856944, 4430.645548356124, 5206.427292997767, 5237.764300606405, 5239.449857764956, 5239.921401178985, 5252.527272545489, 4488.483824360175, 4490.595846373842, 4505.752183629932, 4526.393130438712, 4531.410916580823, 2651.6930270664643, 2777.47239018539, 2786.1502241816443, 2787.665480142396, 2787.9442411152068, 4904.043711476228, 4905.975470122627, 4915.606751459874, 4922.33548470959, 4942.0, 5374.677519348852, 5379.569634429236, 5388.865278367994, 5390.407055223922, 5390.97304513475, 4636.605888499448, 4932.161532539477, 4956.355673762388, 4961.0, 4964.67729597575, 5185.533302002837, 5200.375954885438, 5221.190715439113, 5237.7002488432045, 5243.659162154448, 5187.288194895751, 5212.478752124757, 5237.476252374732, 5244.292020577326, 5248.3701955765555, 4703.811847526061, 4916.311716359641, 4939.728314942713, 4960.280759289811, 4968.403791545038, 3705.4997575326984, 3707.9629203708696, 3709.870154544578, 3731.9253614928093, 3736.9252614947004, 5281.366236051698, 5318.7074710891275, 5330.920036199538, 5338.279332290091, 5346.754363167402, 4943.456219815889, 5100.209467532539, 5100.336956195671, 5109.412417571878, 5152.355955505562, 5101.311322971352, 5102.846914592568, 5109.897802044013, 5128.333316668809, 5141.845744627667, 5002.224655178453, 5004.049230646166, 5005.824796132118, 5009.474005229544, 5025.6482046256415, 4811.446683631427, 4833.139241392019, 5086.982603479245, 5172.405173405106, 5174.818881339135, 4837.7097374157665, 4926.433460151985, 4978.726170060537, 5024.3921944977255, 5032.823851165192], "value": 3838.2657401445526, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.9734061967212, 642.486011191047, 643.7618081309917, 650.1405978900348, 662.4832630548174, 12661.873381266185, 13053.608391748263, 13472.461101555939, 13522.729545409098, 13987.650308742286, 13793.172409655428, 14457.132572045684, 14458.204798736091, 14608.19654918979, 14610.853891461082, 739.1389031777973, 754.5171090502083, 754.8716718157926, 755.3239850333975, 755.879059350504, 589.6255877517764, 609.3327806052365, 728.6575309604477, 751.8195633048084, 753.9434542409314, 802.2659266770897, 802.6428239433454, 802.743122200896, 803.4978138663336, 804.3002587748667, 796.3191471292077, 796.5738329993454, 796.8645330293864, 797.38202892758, 797.4298376660715, 461.0387342391085, 469.8026828731941, 561.3712641841123, 573.7991702903992, 590.7164561010696, 12736.61790146297, 12803.679908002374, 12807.5517356893, 12811.0, 12824.935875320563, 11738.941305293505, 12135.696607584792, 12261.754764904741, 12299.754004919852, 12802.42389092493, 10788.784224315548, 10973.396463194522, 11482.138839586982, 11645.301281923112, 11803.173777835555, 4056.5132184137797, 4064.329385651364, 4090.0605586448355, 4157.438745769313, 4256.616904478581, 60350.094748578806, 60385.99999999956, 60416.39583604152, 60900.695496522676, 61420.0, 9146.725598232064, 9293.58178881952, 9537.713868583953, 9836.901630983599, 9858.408495490294, 16571.17144142788, 16648.667026659397, 16663.91668041652, 16743.74884376711, 16813.32746690143, 6347.270063942706, 6347.460465860361, 6474.870502589922, 6604.966975165094, 6794.116764820542, 3202.8078315301154, 3227.177069847221, 3393.4909763535175, 3421.794692318469, 3491.4937334086417, 2791.9162425126874, 2915.6792752797173, 2923.254570084657, 2926.6634337051087, 3031.6058912341255, 496.9031038947443, 498.9600831933437, 509.20309715295446, 509.74003258338513, 524.3576618642132, 557.9163125531203, 565.9773609055674, 573.8322513684632, 577.9566532509995, 583.2417856786161, 8031.879521807177, 8053.718119865894, 8180.672773089129, 8347.081820999685, 8521.957390213009, 494.47832536674156, 494.96287778416763, 523.0428316181379, 535.7642637239602, 586.0827804485966, 3555.182308069107, 3607.7294202934886, 3782.6973842092566, 3843.9807800961376, 3879.96120038796, 84046.15953840506, 87726.0, 90943.0, 90947.0, 91012.0, 71962.0, 72315.0, 74693.25306746972, 75821.0, 76281.0, 67184.66407668029, 69485.3051469489, 71057.2894271061, 71808.64095679489, 73968.26031739614, 7123.928760712327, 7257.963710181415, 7266.854662906818, 7272.454565907684, 7292.598907060163, 39925.0, 39981.0, 40562.95777816734, 41042.38436423396, 41705.58294417139, 50393.0, 56905.71547142238, 57350.13974790465, 57632.71183644055, 58071.709641451525, 9646.758831029281, 9862.605495780375, 9871.65449209303, 10056.145227655732, 10079.697609071447, 10843.295185813213, 11067.557297708001, 11201.831972520582, 11259.887401126212, 11370.431478426211, 10242.129418999171, 10390.636327728493, 10808.405537695502, 10810.18923580719, 10860.728481788019, 8181.918180818116, 9662.71011869645, 10589.9470502647, 10694.786104278026, 11129.16531260175, 10901.890981090404, 11018.779624407627, 11086.168537359568, 11116.186239561548, 11764.294142351486, 9184.311176661911, 9421.670241541513, 9812.607495700093, 9852.458114803469, 9909.207263419054, 9676.806463870824, 9764.560594773395, 9766.462844543334, 9886.25853061009, 9912.306138570231], "value": 6247.172202725137, "unit": "score"}], "name": "dromaeo_css", "value": 6134.76825869321, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 113.0, 116.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 124.0, 163.0, 128.0, 126.0, 132.0, 131.0, 164.0, 131.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 163.0, 161.0, 161.0, 163.0, 163.0, 161.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 107.0, 77.0, 77.0, 76.0, 76.0, 106.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 82.0, 83.0, 84.0, 112.0, 84.0, 82.0, 124.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 97.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 64.0, 66.0, 66.0, 64.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 67.0, 66.0, 65.0, 65.0, 65.0, 67.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 83.0, 83.0, 82.0, 86.0, 82.0, 88.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 148.0, 138.0, 147.0, 140.0, 139.0, 149.0, 140.0, 177.0, 141.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 180.0, 174.0, 178.0, 175.0, 178.0, 180.0, 174.0, 172.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 75.0, 74.0, 74.0, 71.0, 70.0, 74.0, 69.0, 67.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1556.8000000000002, "alertThreshold": 2.0}]} 04:52:58 INFO - Return code: 0 04:52:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:52:58 INFO - # TBPL SUCCESS # 04:52:58 INFO - Running post-action listener: _resource_record_post_action 04:52:58 INFO - [mozharness: 2016-10-11 11:52:58.302551Z] Finished run-tests step (success) 04:52:58 INFO - Running post-run listener: _resource_record_post_run 04:52:58 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402116608; Read time: 8; Write time: 300900 04:52:58 INFO - TinderboxPrint: CPU usage
13.0% 04:52:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:52:58 INFO - TinderboxPrint: I/O write bytes / time
402,116,608 / 300,900 04:52:58 INFO - TinderboxPrint: CPU idle
8,355.5 (87.0%) 04:52:58 INFO - TinderboxPrint: CPU user
1,202.6 (12.5%) 04:52:58 INFO - TinderboxPrint: Swap in / out
0 / 0 04:52:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110714880; Read time: 0; Write time: 67640 04:52:58 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291401728; Read time: 0; Write time: 233260 04:52:58 INFO - Running post-run listener: _upload_blobber_files 04:52:58 INFO - Blob upload gear active. 04:52:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:52:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:52:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:02 INFO - (blobuploader) - INFO - Done attempting. 04:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:03 INFO - (blobuploader) - INFO - Done attempting. 04:53:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:53:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:53:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:04 INFO - (blobuploader) - INFO - Done attempting. 04:53:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:53:04 INFO - Return code: 0 04:53:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:53:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:53:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4863de29eb0a916dd168cf26b5d849a780e70573e81ac9bd9aa268e8d9e5ab85e3e8b73733e9b7ff91ec7045b5d413b04bdea58cad244c28466811aa9ed75ee7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9cf94298c1cd35252a97f68a5c6462fe1035f54fb6b21c799a9547dd96819950026270231b7ddbf29c450bcf88b031c4cd34fba07f61d98293e09c9800fc35ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4edcb7ffaf51320fe4ef79e99f77bc1f57d9c199b165c2c34b92463f456abc0fa599ee3e6772b085b654056b6f1dd4d09a754c3155cfd95d5b2341f4c5d318cc"} 04:53:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:53:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:53:04 INFO - Contents: 04:53:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4863de29eb0a916dd168cf26b5d849a780e70573e81ac9bd9aa268e8d9e5ab85e3e8b73733e9b7ff91ec7045b5d413b04bdea58cad244c28466811aa9ed75ee7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9cf94298c1cd35252a97f68a5c6462fe1035f54fb6b21c799a9547dd96819950026270231b7ddbf29c450bcf88b031c4cd34fba07f61d98293e09c9800fc35ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4edcb7ffaf51320fe4ef79e99f77bc1f57d9c199b165c2c34b92463f456abc0fa599ee3e6772b085b654056b6f1dd4d09a754c3155cfd95d5b2341f4c5d318cc"} 04:53:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:53:04 INFO - Copying logs to upload dir... 04:53:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:53:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.803987 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-11 04:53:03.171334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 04:53:03.179289) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193 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/4863de29eb0a916dd168cf26b5d849a780e70573e81ac9bd9aa268e8d9e5ab85e3e8b73733e9b7ff91ec7045b5d413b04bdea58cad244c28466811aa9ed75ee7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9cf94298c1cd35252a97f68a5c6462fe1035f54fb6b21c799a9547dd96819950026270231b7ddbf29c450bcf88b031c4cd34fba07f61d98293e09c9800fc35ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4edcb7ffaf51320fe4ef79e99f77bc1f57d9c199b165c2c34b92463f456abc0fa599ee3e6772b085b654056b6f1dd4d09a754c3155cfd95d5b2341f4c5d318cc"} build_url:https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/YUv8Hn-DRgOO2xQihvYDnw/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/4863de29eb0a916dd168cf26b5d849a780e70573e81ac9bd9aa268e8d9e5ab85e3e8b73733e9b7ff91ec7045b5d413b04bdea58cad244c28466811aa9ed75ee7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9cf94298c1cd35252a97f68a5c6462fe1035f54fb6b21c799a9547dd96819950026270231b7ddbf29c450bcf88b031c4cd34fba07f61d98293e09c9800fc35ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4edcb7ffaf51320fe4ef79e99f77bc1f57d9c199b165c2c34b92463f456abc0fa599ee3e6772b085b654056b6f1dd4d09a754c3155cfd95d5b2341f4c5d318cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 04:53:03.210726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:53:03.211121) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1476184867.804284-169964193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:53:03.290366) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 04:53:03.293700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 04:53:03.294000) ========= ========= Total master_lag: 0.20 =========