builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1478178905.14 results: success (0) buildid: 20161103030205 builduid: 1d1483cf12d64dbbac00c1ce9f64e2ad revision: ade8d4a63e57560410de106450f37b50ed71cca5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:05.142121) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:05.142559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:05.142843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:05.157654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:05.158058) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-03 06:15:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-11-03 06:15:05 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100621 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:05.272306) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:05.272653) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:05.322008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:05.322388) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ade8d4a63e57560410de106450f37b50ed71cca5 --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 ade8d4a63e57560410de106450f37b50ed71cca5 --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=d6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-03 06:15:05,894 truncating revision to first 12 chars 2016-11-03 06:15:05,894 Setting DEBUG logging. 2016-11-03 06:15:05,894 attempt 1/10 2016-11-03 06:15:05,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ade8d4a63e57?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-03 06:15:06,526 unpacking tar archive at: mozilla-central-ade8d4a63e57/testing/mozharness/ program finished with exit code 0 elapsedTime=0.932031 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:06.267828) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:06.268187) ========= script_repo_revision: ade8d4a63e57560410de106450f37b50ed71cca5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:06.268587) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:06.268869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 06:15:06.277351) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-03 06:15:06.277747) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:15:06 INFO - MultiFileLogger online at 20161103 06:15:06 in /builds/slave/test 06:15:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:15:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:15:06 INFO - {'append_to_log': False, 06:15:06 INFO - 'base_work_dir': '/builds/slave/test', 06:15:06 INFO - 'blob_upload_branch': 'Firefox', 06:15:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:15:06 INFO - 'branch': 'Firefox', 06:15:06 INFO - 'buildbot_json_path': 'buildprops.json', 06:15:06 INFO - 'config_files': ('talos/linux_config.py',), 06:15:06 INFO - 'default_actions': ('clobber', 06:15:06 INFO - 'read-buildbot-config', 06:15:06 INFO - 'download-and-extract', 06:15:06 INFO - 'populate-webroot', 06:15:06 INFO - 'create-virtualenv', 06:15:06 INFO - 'install', 06:15:06 INFO - 'run-tests'), 06:15:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:15:06 INFO - 'download_minidump_stackwalk': True, 06:15:06 INFO - 'download_symbols': 'ondemand', 06:15:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:15:06 INFO - 'tooltool.py': '/tools/tooltool.py', 06:15:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:15:06 INFO - '/tools/misc-python/virtualenv.py')}, 06:15:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:15:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:15:06 INFO - 'installer_path': 'installer.exe', 06:15:06 INFO - 'log_level': 'info', 06:15:06 INFO - 'log_name': 'talos', 06:15:06 INFO - 'log_to_console': True, 06:15:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:15:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:15:06 INFO - 'opt_config_files': (), 06:15:06 INFO - 'pip_index': False, 06:15:06 INFO - 'sps_profile': False, 06:15:06 INFO - 'sps_profile_interval': 0, 06:15:06 INFO - 'suite': 'dromaeojs', 06:15:06 INFO - 'system_bits': '32', 06:15:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:15:06 INFO - 'title': 'talos-linux64-ix-034', 06:15:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:15:06 INFO - 'use_talos_json': True, 06:15:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:15:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:15:06 INFO - 'work_dir': 'build'} 06:15:06 INFO - [mozharness: 2016-11-03 13:15:06.938172Z] Running clobber step. 06:15:06 INFO - Running pre-action listener: _resource_record_pre_action 06:15:06 INFO - Running main action method: clobber 06:15:06 INFO - rmtree: /builds/slave/test/build 06:15:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:15:07 INFO - Running post-action listener: _resource_record_post_action 06:15:07 INFO - [mozharness: 2016-11-03 13:15:07.401017Z] Finished clobber step (success) 06:15:07 INFO - [mozharness: 2016-11-03 13:15:07.401119Z] Running read-buildbot-config step. 06:15:07 INFO - Running pre-action listener: _resource_record_pre_action 06:15:07 INFO - Running main action method: read_buildbot_config 06:15:07 INFO - Using buildbot properties: 06:15:07 INFO - { 06:15:07 INFO - "project": "", 06:15:07 INFO - "product": "firefox", 06:15:07 INFO - "script_repo_revision": "production", 06:15:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:15:07 INFO - "repository": "", 06:15:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:15:07 INFO - "buildid": "20161103030205", 06:15:07 INFO - "stage_platform": "linux64-pgo", 06:15:07 INFO - "basedir": "/builds/slave/test", 06:15:07 INFO - "nightly_build": "True", 06:15:07 INFO - "buildnumber": 53, 06:15:07 INFO - "slavename": "talos-linux64-ix-034", 06:15:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:15:07 INFO - "platform": "ubuntu64_hw", 06:15:07 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:15:07 INFO - "branch": "mozilla-central", 06:15:07 INFO - "repo_path": "mozilla-central", 06:15:07 INFO - "revision": "ade8d4a63e57560410de106450f37b50ed71cca5", 06:15:07 INFO - "pgo_build": "True", 06:15:07 INFO - "builduid": "1d1483cf12d64dbbac00c1ce9f64e2ad", 06:15:07 INFO - "slavebuilddir": "test" 06:15:07 INFO - } 06:15:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:15:07 INFO - Running post-action listener: _resource_record_post_action 06:15:07 INFO - [mozharness: 2016-11-03 13:15:07.403664Z] Finished read-buildbot-config step (success) 06:15:07 INFO - [mozharness: 2016-11-03 13:15:07.403751Z] Running download-and-extract step. 06:15:07 INFO - Running pre-action listener: _resource_record_pre_action 06:15:07 INFO - Running main action method: download_and_extract 06:15:07 INFO - mkdir: /builds/slave/test/build/tests 06:15:07 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')]} 06:15:07 INFO - trying https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:15:07 INFO - Downloading https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/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 06:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/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 06:15:07 INFO - Downloaded 1361 bytes. 06:15:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:15:07 INFO - Using the following test package requirements: 06:15:07 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:15:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:15:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:15:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:07 INFO - u'jsshell-linux-x86_64.zip'], 06:15:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:15:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:15:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:15:07 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:15:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:15:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:15:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:15:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:15:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:15:07 INFO - Fetch https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:15:08 INFO - Http code: 200 06:15:08 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 06:15:08 INFO - x-amz-cf-id: A9b2HHRF65jA_dFuo3y0KR7qsCisplAWBZAY9J7LmsHVXMKofXTfag== 06:15:08 INFO - x-amz-version-id: byqTLlF8aaDfnDTQ3DXAN35gcSrLVe_W 06:15:08 INFO - Expected file size: 22002050 06:15:08 INFO - Obtained file size: 22002050 06:15:12 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 06:15:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:15:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:15:12 INFO - Fetch https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:15:13 INFO - Http code: 200 06:15:13 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 06:15:13 INFO - x-amz-cf-id: GSv_vtOJd9pINvRA1hVhWmSSQ4sVleOtCKVmlWGeF6reAtDgdiRJWw== 06:15:13 INFO - x-amz-version-id: byqTLlF8aaDfnDTQ3DXAN35gcSrLVe_W 06:15:13 INFO - Expected file size: 22002050 06:15:13 INFO - Obtained file size: 22002050 06:15:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:15:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:15:18 INFO - Fetch https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:15:18 INFO - Http code: 200 06:15:18 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 06:15:18 INFO - x-amz-cf-id: ujcJyIn9_IqQpXcLCbDnqHZWWTKU0QQYT2K4gMlJL7HnHOEf5D4ynQ== 06:15:18 INFO - x-amz-version-id: 9_DEGlkV4gKHHRCCZbrDxNeuCN4zNnep 06:15:19 INFO - Expected file size: 14409038 06:15:19 INFO - Obtained file size: 14409038 06:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:19 INFO - trying https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:15:19 INFO - Downloading https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/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 06:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/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 06:15:20 INFO - Downloaded 59623217 bytes. 06:15:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:15:20 INFO - mkdir: /builds/slave/test/properties 06:15:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:15:20 INFO - Writing to file /builds/slave/test/properties/build_url 06:15:20 INFO - Contents: 06:15:20 INFO - build_url:https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:15:21 INFO - Running post-action listener: _resource_record_post_action 06:15:21 INFO - Running post-action listener: set_extra_try_arguments 06:15:21 INFO - [mozharness: 2016-11-03 13:15:21.314953Z] Finished download-and-extract step (success) 06:15:21 INFO - [mozharness: 2016-11-03 13:15:21.315180Z] Running populate-webroot step. 06:15:21 INFO - Running pre-action listener: _resource_record_pre_action 06:15:21 INFO - Running main action method: populate_webroot 06:15:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:15:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:15:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:15:21 INFO - '--tppagecycles', 06:15:21 INFO - '7'], 06:15:21 INFO - 'tests': ['tsvgm']}}, 06:15:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:15:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:15:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:15:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:15:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['damp', 'tps']}, 06:15:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'tests': ['damp', 'tps']}, 06:15:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['dromaeo_dom']}, 06:15:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:15:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['basic_compositor_video']}, 06:15:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:15:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'other-e10s': {'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['a11yr', 06:15:21 INFO - 'ts_paint', 06:15:21 INFO - 'tpaint', 06:15:21 INFO - 'sessionrestore', 06:15:21 INFO - 'sessionrestore_no_auto_restore', 06:15:21 INFO - 'tabpaint']}, 06:15:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['tsvgx', 06:15:21 INFO - 'tsvgr_opacity', 06:15:21 INFO - 'tart', 06:15:21 INFO - 'tscrollx', 06:15:21 INFO - 'cart']}, 06:15:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:15:21 INFO - 'tsvgr_opacity', 06:15:21 INFO - 'tart', 06:15:21 INFO - 'tscrollx', 06:15:21 INFO - 'cart']}, 06:15:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'talos_options': ['--disable-e10s'], 06:15:21 INFO - 'tests': ['tp5o']}, 06:15:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'tests': ['tp5o']}, 06:15:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'talos_options': ['--disable-e10s', 06:15:21 INFO - '--xperf_path', 06:15:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:21 INFO - 'tests': ['tp5n']}, 06:15:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:21 INFO - 'talos_options': ['--xperf_path', 06:15:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:21 INFO - 'tests': ['tp5n']}}, 06:15:21 INFO - 'talos.zip': {'path': '', 06:15:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:15:21 INFO - Running post-action listener: _resource_record_post_action 06:15:21 INFO - [mozharness: 2016-11-03 13:15:21.332533Z] Finished populate-webroot step (success) 06:15:21 INFO - [mozharness: 2016-11-03 13:15:21.332622Z] Running create-virtualenv step. 06:15:21 INFO - Running pre-action listener: _resource_record_pre_action 06:15:21 INFO - Running main action method: create_virtualenv 06:15:21 INFO - Creating virtualenv /builds/slave/test/build/venv 06:15:21 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 06:15:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:15:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:15:21 INFO - Using real prefix '/usr' 06:15:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:15:21 INFO - Installing distribute.............................................................................................................................................................................................done. 06:15:23 INFO - Installing pip.................done. 06:15:23 INFO - Return code: 0 06:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:15:24 INFO - Reading from file tmpfile_stdout 06:15:24 INFO - Output received: 06:15:24 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) 06:15:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1dae2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', '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 06:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:15:24 INFO - Using env: {'DISPLAY': ':0', 06:15:24 INFO - 'HOME': '/home/cltbld', 06:15:24 INFO - 'LANG': 'en_US.UTF-8', 06:15:24 INFO - 'LANGUAGE': 'en_US:en', 06:15:24 INFO - 'LOGNAME': 'cltbld', 06:15:24 INFO - 'MAIL': '/var/mail/cltbld', 06:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:24 INFO - 'MOZ_NO_REMOTE': '1', 06:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:24 INFO - 'NO_EM_RESTART': '1', 06:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:24 INFO - 'PWD': '/builds/slave/test', 06:15:24 INFO - 'SHELL': '/bin/bash', 06:15:24 INFO - 'SHLVL': '1', 06:15:24 INFO - 'TERM': 'linux', 06:15:24 INFO - 'TMOUT': '86400', 06:15:24 INFO - 'USER': 'cltbld', 06:15:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:24 INFO - '_': '/tools/buildbot/bin/python'} 06:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:24 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 06:15:24 INFO - Cleaning up... 06:15:24 INFO - Return code: 0 06:15:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1dae2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', '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 06:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:15:24 INFO - Using env: {'DISPLAY': ':0', 06:15:24 INFO - 'HOME': '/home/cltbld', 06:15:24 INFO - 'LANG': 'en_US.UTF-8', 06:15:24 INFO - 'LANGUAGE': 'en_US:en', 06:15:24 INFO - 'LOGNAME': 'cltbld', 06:15:24 INFO - 'MAIL': '/var/mail/cltbld', 06:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:24 INFO - 'MOZ_NO_REMOTE': '1', 06:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:24 INFO - 'NO_EM_RESTART': '1', 06:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:24 INFO - 'PWD': '/builds/slave/test', 06:15:24 INFO - 'SHELL': '/bin/bash', 06:15:24 INFO - 'SHLVL': '1', 06:15:24 INFO - 'TERM': 'linux', 06:15:24 INFO - 'TMOUT': '86400', 06:15:24 INFO - 'USER': 'cltbld', 06:15:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:24 INFO - '_': '/tools/buildbot/bin/python'} 06:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:24 INFO - Downloading/unpacking psutil>=3.1.1 06:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:15:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:26 INFO - Installing collected packages: psutil 06:15:26 INFO - Running setup.py install for psutil 06:15:26 INFO - building 'psutil._psutil_linux' extension 06:15:26 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 06:15:26 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 06:15:26 INFO - building 'psutil._psutil_posix' extension 06:15:26 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 06:15:27 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 06:15:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:27 INFO - Successfully installed psutil 06:15:27 INFO - Cleaning up... 06:15:27 INFO - Return code: 0 06:15:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1dae2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', '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 06:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:15:27 INFO - Using env: {'DISPLAY': ':0', 06:15:27 INFO - 'HOME': '/home/cltbld', 06:15:27 INFO - 'LANG': 'en_US.UTF-8', 06:15:27 INFO - 'LANGUAGE': 'en_US:en', 06:15:27 INFO - 'LOGNAME': 'cltbld', 06:15:27 INFO - 'MAIL': '/var/mail/cltbld', 06:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:27 INFO - 'MOZ_NO_REMOTE': '1', 06:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:27 INFO - 'NO_EM_RESTART': '1', 06:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:27 INFO - 'PWD': '/builds/slave/test', 06:15:27 INFO - 'SHELL': '/bin/bash', 06:15:27 INFO - 'SHLVL': '1', 06:15:27 INFO - 'TERM': 'linux', 06:15:27 INFO - 'TMOUT': '86400', 06:15:27 INFO - 'USER': 'cltbld', 06:15:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:27 INFO - '_': '/tools/buildbot/bin/python'} 06:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:15:29 INFO - Installing collected packages: mozsystemmonitor 06:15:29 INFO - Running setup.py install for mozsystemmonitor 06:15:29 INFO - Successfully installed mozsystemmonitor 06:15:29 INFO - Cleaning up... 06:15:29 INFO - Return code: 0 06:15:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1dae2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', '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 06:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:15:29 INFO - Using env: {'DISPLAY': ':0', 06:15:29 INFO - 'HOME': '/home/cltbld', 06:15:29 INFO - 'LANG': 'en_US.UTF-8', 06:15:29 INFO - 'LANGUAGE': 'en_US:en', 06:15:29 INFO - 'LOGNAME': 'cltbld', 06:15:29 INFO - 'MAIL': '/var/mail/cltbld', 06:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:29 INFO - 'MOZ_NO_REMOTE': '1', 06:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:29 INFO - 'NO_EM_RESTART': '1', 06:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:29 INFO - 'PWD': '/builds/slave/test', 06:15:29 INFO - 'SHELL': '/bin/bash', 06:15:29 INFO - 'SHLVL': '1', 06:15:29 INFO - 'TERM': 'linux', 06:15:29 INFO - 'TMOUT': '86400', 06:15:29 INFO - 'USER': 'cltbld', 06:15:29 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:29 INFO - '_': '/tools/buildbot/bin/python'} 06:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:29 INFO - Downloading/unpacking jsonschema==2.5.1 06:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:31 INFO - warning: no files found matching '*.txt' 06:15:31 INFO - no previously-included directories found matching 'build' 06:15:31 INFO - no previously-included directories found matching 'dist' 06:15:31 INFO - no previously-included directories found matching '.git*' 06:15:31 INFO - Installing collected packages: jsonschema, functools32 06:15:32 INFO - Running setup.py install for functools32 06:15:32 INFO - warning: no files found matching '*.txt' 06:15:32 INFO - no previously-included directories found matching 'build' 06:15:32 INFO - no previously-included directories found matching 'dist' 06:15:32 INFO - no previously-included directories found matching '.git*' 06:15:32 INFO - Successfully installed jsonschema functools32 06:15:32 INFO - Cleaning up... 06:15:32 INFO - Return code: 0 06:15:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:15:32 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')]} 06:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:32 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')]} 06:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:32 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 0x7f1dae2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', '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 06:15:32 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 06:15:32 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 06:15:32 INFO - Using env: {'DISPLAY': ':0', 06:15:32 INFO - 'HOME': '/home/cltbld', 06:15:32 INFO - 'LANG': 'en_US.UTF-8', 06:15:32 INFO - 'LANGUAGE': 'en_US:en', 06:15:32 INFO - 'LOGNAME': 'cltbld', 06:15:32 INFO - 'MAIL': '/var/mail/cltbld', 06:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:32 INFO - 'MOZ_NO_REMOTE': '1', 06:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:32 INFO - 'NO_EM_RESTART': '1', 06:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:32 INFO - 'PWD': '/builds/slave/test', 06:15:32 INFO - 'SHELL': '/bin/bash', 06:15:32 INFO - 'SHLVL': '1', 06:15:32 INFO - 'TERM': 'linux', 06:15:32 INFO - 'TMOUT': '86400', 06:15:32 INFO - 'USER': 'cltbld', 06:15:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:32 INFO - '_': '/tools/buildbot/bin/python'} 06:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:15:32 INFO - Cleaning up... 06:15:32 INFO - Return code: 0 06:15:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:15:32 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')]} 06:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:32 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')]} 06:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:32 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 0x7f1dae2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', '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 06:15:32 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 06:15:32 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 06:15:32 INFO - Using env: {'DISPLAY': ':0', 06:15:32 INFO - 'HOME': '/home/cltbld', 06:15:32 INFO - 'LANG': 'en_US.UTF-8', 06:15:32 INFO - 'LANGUAGE': 'en_US:en', 06:15:32 INFO - 'LOGNAME': 'cltbld', 06:15:32 INFO - 'MAIL': '/var/mail/cltbld', 06:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:32 INFO - 'MOZ_NO_REMOTE': '1', 06:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:32 INFO - 'NO_EM_RESTART': '1', 06:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:32 INFO - 'PWD': '/builds/slave/test', 06:15:32 INFO - 'SHELL': '/bin/bash', 06:15:32 INFO - 'SHLVL': '1', 06:15:32 INFO - 'TERM': 'linux', 06:15:32 INFO - 'TMOUT': '86400', 06:15:32 INFO - 'USER': 'cltbld', 06:15:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:32 INFO - '_': '/tools/buildbot/bin/python'} 06:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:32 INFO - Downloading/unpacking blobuploader==1.2.4 06:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:34 INFO - Downloading blobuploader-1.2.4.tar.gz 06:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:15:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:15: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 06:15: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 06:15: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 06:15: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 06:15: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 06:15: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 06:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:15:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:35 INFO - Downloading docopt-0.6.1.tar.gz 06:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:15:35 INFO - Installing collected packages: blobuploader, requests, docopt 06:15:35 INFO - Running setup.py install for blobuploader 06:15:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:15:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:15:35 INFO - Running setup.py install for requests 06:15:35 INFO - Running setup.py install for docopt 06:15:35 INFO - Successfully installed blobuploader requests docopt 06:15:35 INFO - Cleaning up... 06:15:35 INFO - Return code: 0 06:15:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:35 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 0x7f1dae2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', '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 06:15:35 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 06:15:35 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 06:15:35 INFO - Using env: {'DISPLAY': ':0', 06:15:35 INFO - 'HOME': '/home/cltbld', 06:15:35 INFO - 'LANG': 'en_US.UTF-8', 06:15:35 INFO - 'LANGUAGE': 'en_US:en', 06:15:35 INFO - 'LOGNAME': 'cltbld', 06:15:35 INFO - 'MAIL': '/var/mail/cltbld', 06:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:35 INFO - 'MOZ_NO_REMOTE': '1', 06:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:35 INFO - 'NO_EM_RESTART': '1', 06:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:35 INFO - 'PWD': '/builds/slave/test', 06:15:35 INFO - 'SHELL': '/bin/bash', 06:15:35 INFO - 'SHLVL': '1', 06:15:35 INFO - 'TERM': 'linux', 06:15:35 INFO - 'TMOUT': '86400', 06:15:35 INFO - 'USER': 'cltbld', 06:15:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:35 INFO - '_': '/tools/buildbot/bin/python'} 06:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:36 INFO - Running setup.py (path:/tmp/pip-bHVBFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:36 INFO - Running setup.py (path:/tmp/pip-IMrava-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:36 INFO - Running setup.py (path:/tmp/pip-Pe32LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:36 INFO - Running setup.py (path:/tmp/pip-ylZz7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:36 INFO - Running setup.py (path:/tmp/pip-lmSuI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:36 INFO - Running setup.py (path:/tmp/pip-nDl_jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:36 INFO - Running setup.py (path:/tmp/pip-KNc6yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:36 INFO - Running setup.py (path:/tmp/pip-soQ4BI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:36 INFO - Running setup.py (path:/tmp/pip-3rSTrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:36 INFO - Running setup.py (path:/tmp/pip-tQi17n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:36 INFO - Running setup.py (path:/tmp/pip-v2eXi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:36 INFO - Running setup.py (path:/tmp/pip-vwXhjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:37 INFO - Running setup.py (path:/tmp/pip-73ja2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:37 INFO - Running setup.py (path:/tmp/pip-6XhRWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:37 INFO - Running setup.py (path:/tmp/pip-xNtk0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:37 INFO - Running setup.py (path:/tmp/pip-b1oHDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:37 INFO - Running setup.py (path:/tmp/pip-9WOjZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:15:37 INFO - Running setup.py install for manifestparser 06:15:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:15:37 INFO - Running setup.py install for mozcrash 06:15:37 INFO - Running setup.py install for mozdebug 06:15:37 INFO - Running setup.py install for mozdevice 06:15:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:15:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:15:37 INFO - Running setup.py install for mozfile 06:15:37 INFO - Running setup.py install for mozhttpd 06:15:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:15:37 INFO - Running setup.py install for mozinfo 06:15:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Running setup.py install for mozInstall 06:15:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Running setup.py install for mozleak 06:15:38 INFO - Running setup.py install for mozlog 06:15:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Running setup.py install for moznetwork 06:15:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Running setup.py install for mozprocess 06:15:38 INFO - Running setup.py install for mozprofile 06:15:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Running setup.py install for mozrunner 06:15:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:15:38 INFO - Running setup.py install for mozscreenshot 06:15:38 INFO - Running setup.py install for moztest 06:15:39 INFO - Running setup.py install for mozversion 06:15:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:15:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:15:39 INFO - Cleaning up... 06:15:39 INFO - Return code: 0 06:15:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:39 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 0x7f1dae2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', '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 06:15:39 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 06:15:39 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 06:15:39 INFO - Using env: {'DISPLAY': ':0', 06:15:39 INFO - 'HOME': '/home/cltbld', 06:15:39 INFO - 'LANG': 'en_US.UTF-8', 06:15:39 INFO - 'LANGUAGE': 'en_US:en', 06:15:39 INFO - 'LOGNAME': 'cltbld', 06:15:39 INFO - 'MAIL': '/var/mail/cltbld', 06:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:39 INFO - 'MOZ_NO_REMOTE': '1', 06:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:39 INFO - 'NO_EM_RESTART': '1', 06:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:39 INFO - 'PWD': '/builds/slave/test', 06:15:39 INFO - 'SHELL': '/bin/bash', 06:15:39 INFO - 'SHLVL': '1', 06:15:39 INFO - 'TERM': 'linux', 06:15:39 INFO - 'TMOUT': '86400', 06:15:39 INFO - 'USER': 'cltbld', 06:15:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:39 INFO - '_': '/tools/buildbot/bin/python'} 06:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:39 INFO - Running setup.py (path:/tmp/pip-hHSDIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:39 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)) 06:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:39 INFO - Running setup.py (path:/tmp/pip-IbuME7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:39 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)) 06:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:39 INFO - Running setup.py (path:/tmp/pip-phuXvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:39 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)) 06:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:39 INFO - Running setup.py (path:/tmp/pip-amZlkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:39 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)) 06:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:39 INFO - Running setup.py (path:/tmp/pip-t8ayuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:39 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)) 06:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:39 INFO - Running setup.py (path:/tmp/pip-li7WOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:39 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)) 06:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:39 INFO - Running setup.py (path:/tmp/pip-cWK3ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:39 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)) 06:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:39 INFO - Running setup.py (path:/tmp/pip-3tqXol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:39 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)) 06:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:39 INFO - Running setup.py (path:/tmp/pip-VefRI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:40 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)) 06:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:40 INFO - Running setup.py (path:/tmp/pip-y_X6lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:40 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)) 06:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:40 INFO - Running setup.py (path:/tmp/pip-5_8XBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:40 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)) 06:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:40 INFO - Running setup.py (path:/tmp/pip-g2BZi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:40 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)) 06:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:40 INFO - Running setup.py (path:/tmp/pip-d0sBJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:40 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)) 06:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:40 INFO - Running setup.py (path:/tmp/pip-TqYL07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:40 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)) 06:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:40 INFO - Running setup.py (path:/tmp/pip-hZwPWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:40 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)) 06:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:40 INFO - Running setup.py (path:/tmp/pip-lDHXbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:40 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)) 06:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:40 INFO - Running setup.py (path:/tmp/pip-eoDtM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 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)) 06:15:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15: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 06:15: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 06:15: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 06:15: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 06:15: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 06:15: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 06:15:42 INFO - Downloading blessings-1.6.tar.gz 06:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:42 INFO - Installing collected packages: blessings 06:15:42 INFO - Running setup.py install for blessings 06:15:42 INFO - Successfully installed blessings 06:15:42 INFO - Cleaning up... 06:15:42 INFO - Return code: 0 06:15:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:43 INFO - Reading from file tmpfile_stdout 06:15:43 INFO - Current package versions: 06:15:43 INFO - argparse == 1.2.1 06:15:43 INFO - blessings == 1.6 06:15:43 INFO - blobuploader == 1.2.4 06:15:43 INFO - docopt == 0.6.1 06:15:43 INFO - functools32 == 3.2.3-2 06:15:43 INFO - jsonschema == 2.5.1 06:15:43 INFO - manifestparser == 1.1 06:15:43 INFO - mozInstall == 1.12 06:15:43 INFO - mozcrash == 0.17 06:15:43 INFO - mozdebug == 0.1 06:15:43 INFO - mozdevice == 0.48 06:15:43 INFO - mozfile == 1.2 06:15:43 INFO - mozhttpd == 0.7 06:15:43 INFO - mozinfo == 0.9 06:15:43 INFO - mozleak == 0.1 06:15:43 INFO - mozlog == 3.4 06:15:43 INFO - moznetwork == 0.27 06:15:43 INFO - mozprocess == 0.23 06:15:43 INFO - mozprofile == 0.28 06:15:43 INFO - mozrunner == 6.12 06:15:43 INFO - mozscreenshot == 0.1 06:15:43 INFO - mozsystemmonitor == 0.3 06:15:43 INFO - moztest == 0.7 06:15:43 INFO - mozversion == 1.4 06:15:43 INFO - psutil == 3.1.1 06:15:43 INFO - requests == 1.2.3 06:15:43 INFO - wsgiref == 0.1.2 06:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:43 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 0x7f1dae2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', '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 06:15:43 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 06:15:43 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 06:15:43 INFO - Using env: {'DISPLAY': ':0', 06:15:43 INFO - 'HOME': '/home/cltbld', 06:15:43 INFO - 'LANG': 'en_US.UTF-8', 06:15:43 INFO - 'LANGUAGE': 'en_US:en', 06:15:43 INFO - 'LOGNAME': 'cltbld', 06:15:43 INFO - 'MAIL': '/var/mail/cltbld', 06:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:43 INFO - 'MOZ_NO_REMOTE': '1', 06:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:43 INFO - 'NO_EM_RESTART': '1', 06:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:43 INFO - 'PWD': '/builds/slave/test', 06:15:43 INFO - 'SHELL': '/bin/bash', 06:15:43 INFO - 'SHLVL': '1', 06:15:43 INFO - 'TERM': 'linux', 06:15:43 INFO - 'TMOUT': '86400', 06:15:43 INFO - 'USER': 'cltbld', 06:15:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:43 INFO - '_': '/tools/buildbot/bin/python'} 06:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:43 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)) 06:15:43 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)) 06:15:43 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)) 06:15:43 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)) 06:15:43 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)) 06:15:43 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)) 06:15:43 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)) 06:15:43 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)) 06:15:43 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)) 06:15:43 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)) 06:15:43 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)) 06:15:43 INFO - Cleaning up... 06:15:43 INFO - Return code: 0 06:15:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1dae2a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb8790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', '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 06:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:15:43 INFO - Using env: {'DISPLAY': ':0', 06:15:43 INFO - 'HOME': '/home/cltbld', 06:15:43 INFO - 'LANG': 'en_US.UTF-8', 06:15:43 INFO - 'LANGUAGE': 'en_US:en', 06:15:43 INFO - 'LOGNAME': 'cltbld', 06:15:43 INFO - 'MAIL': '/var/mail/cltbld', 06:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:43 INFO - 'MOZ_NO_REMOTE': '1', 06:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:43 INFO - 'NO_EM_RESTART': '1', 06:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:43 INFO - 'PWD': '/builds/slave/test', 06:15:43 INFO - 'SHELL': '/bin/bash', 06:15:43 INFO - 'SHLVL': '1', 06:15:43 INFO - 'TERM': 'linux', 06:15:43 INFO - 'TMOUT': '86400', 06:15:43 INFO - 'USER': 'cltbld', 06:15:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:43 INFO - '_': '/tools/buildbot/bin/python'} 06:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:15:43 INFO - Cleaning up... 06:15:43 INFO - Return code: 0 06:15:43 INFO - Running post-action listener: _resource_record_post_action 06:15:43 INFO - Running post-action listener: _start_resource_monitoring 06:15:43 INFO - Starting resource monitoring. 06:15:43 INFO - [mozharness: 2016-11-03 13:15:43.534675Z] Finished create-virtualenv step (success) 06:15:43 INFO - [mozharness: 2016-11-03 13:15:43.535189Z] Running install step. 06:15:43 INFO - Running pre-action listener: _resource_record_pre_action 06:15:43 INFO - Running main action method: install 06:15:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:43 INFO - Reading from file tmpfile_stdout 06:15:43 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:43 INFO - Reading from file tmpfile_stdout 06:15:43 INFO - Output received: 06:15:43 INFO - Usage: mozinstall [options] installer 06:15:43 INFO - Options: 06:15:43 INFO - -h, --help show this help message and exit 06:15:43 INFO - -d DEST, --destination=DEST 06:15:43 INFO - Directory to install application into. [default: 06:15:43 INFO - "/builds/slave/test"] 06:15:43 INFO - --app=APP Application being installed. [default: firefox] 06:15:43 INFO - mkdir: /builds/slave/test/build/application 06:15:43 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'] 06:15:43 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 06:16:00 INFO - Reading from file tmpfile_stdout 06:16:00 INFO - Output received: 06:16:00 INFO - /builds/slave/test/build/application/firefox/firefox 06:16:00 INFO - Running post-action listener: _resource_record_post_action 06:16:00 INFO - [mozharness: 2016-11-03 13:16:00.817965Z] Finished install step (success) 06:16:00 INFO - [mozharness: 2016-11-03 13:16:00.818212Z] Running run-tests step. 06:16:00 INFO - Running pre-action listener: _resource_record_pre_action 06:16:00 INFO - Running main action method: run_tests 06:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:16:00 INFO - Python 2.7.3 06:16:00 INFO - Return code: 0 06:16:00 INFO - grabbing minidump binary from tooltool 06:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:00 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 0xfb5930>, '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 0xfb6830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb6cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:16:00 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 06:16:00 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 06:16:00 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 06:16:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:16:00 INFO - Return code: 0 06:16:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:16:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:16:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:16:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:16:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 06:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 06:16:00 INFO - Using env: {'DISPLAY': ':0', 06:16:00 INFO - 'HOME': '/home/cltbld', 06:16:00 INFO - 'LANG': 'en_US.UTF-8', 06:16:00 INFO - 'LANGUAGE': 'en_US:en', 06:16:00 INFO - 'LOGNAME': 'cltbld', 06:16:00 INFO - 'MAIL': '/var/mail/cltbld', 06:16:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:16:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:00 INFO - 'MOZ_NO_REMOTE': '1', 06:16:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:00 INFO - 'NO_EM_RESTART': '1', 06:16:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:00 INFO - 'PWD': '/builds/slave/test', 06:16:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:16:00 INFO - 'SHELL': '/bin/bash', 06:16:00 INFO - 'SHLVL': '1', 06:16:00 INFO - 'TERM': 'linux', 06:16:00 INFO - 'TMOUT': '86400', 06:16:00 INFO - 'USER': 'cltbld', 06:16:00 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098', 06:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:00 INFO - '_': '/tools/buildbot/bin/python'} 06:16:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 06:16:01 INFO - mozversion application_buildid: 20161103030205 06:16:01 INFO - mozversion application_changeset: ade8d4a63e57560410de106450f37b50ed71cca5 06:16:01 INFO - mozversion application_display_name: Nightly 06:16:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:16:01 INFO - mozversion application_name: Firefox 06:16:01 INFO - mozversion application_remotingname: firefox 06:16:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:16:01 INFO - mozversion application_vendor: Mozilla 06:16:01 INFO - mozversion application_version: 52.0a1 06:16:01 INFO - mozversion platform_buildid: 20161103030205 06:16:01 INFO - mozversion platform_changeset: ade8d4a63e57560410de106450f37b50ed71cca5 06:16:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:16:01 INFO - mozversion platform_version: 52.0a1 06:16:01 INFO - using testdate: 1478178961 06:16:01 INFO - actual date: 1478178961 06:16:01 INFO - starting webserver on 'localhost:48987' 06:16:01 INFO - SUITE-START | Running 2 tests 06:16:01 INFO - TEST-START | dromaeo_css 06:16:01 INFO - operating with platform_type : linux_ 06:16:01 INFO - Initialising browser for dromaeo_css test... 06:16:01 INFO - TEST-INFO | started process 17802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDULuJb/profile http://localhost:48987/getInfo.html) 06:16:05 INFO - PROCESS | 17802 | __metrics Screen width/height:1600/1200 06:16:05 INFO - PROCESS | 17802 | colorDepth:24 06:16:05 INFO - PROCESS | 17802 | Browser inner width/height: 1024/697 06:16:05 INFO - PROCESS | 17802 | __metrics 06:16:05 INFO - PROCESS | 17802 | 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" 06:16:05 INFO - PROCESS | 17802 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:16:06 INFO - PROCESS | 17802 | console.error: PushService: 06:16:06 INFO - PROCESS | 17802 | stateChangeProcessEnqueue: Error transitioning state 06:16:06 INFO - PROCESS | 17802 | UnknownError 06:16:07 INFO - TEST-INFO | 17802: exit 0 06:16:07 INFO - Browser initialized. 06:16:07 INFO - Running cycle 1/1 for dromaeo_css test... 06:16:07 INFO - TEST-INFO | started process 17887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDULuJb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:19 INFO - PROCESS | 17887 | RSS: Main: 172503040 06:16:19 INFO - PROCESS | 17887 | 06:17:10 INFO - PROCESS | 17887 | 1478179030963 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] 06:19:20 INFO - PROCESS | 17887 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48987/tests/dromaeo/cssquery-ext.html) 06:19:23 INFO - PROCESS | 17887 | RSS: Main: 282882048 06:19:23 INFO - PROCESS | 17887 | 06:22:25 INFO - PROCESS | 17887 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-ext.html (next: http://localhost:48987/tests/dromaeo/cssquery-jquery.html) 06:22:26 INFO - PROCESS | 17887 | RSS: Main: 285663232 06:22:26 INFO - PROCESS | 17887 | 06:25:28 INFO - PROCESS | 17887 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48987/tests/dromaeo/cssquery-mootools.html) 06:25:29 INFO - PROCESS | 17887 | RSS: Main: 265117696 06:25:29 INFO - PROCESS | 17887 | 06:28:31 INFO - PROCESS | 17887 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48987/tests/dromaeo/cssquery-prototype.html) 06:28:31 INFO - PROCESS | 17887 | RSS: Main: 241414144 06:28:31 INFO - PROCESS | 17887 | 06:31:34 INFO - PROCESS | 17887 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48987/tests/dromaeo/cssquery-yui.html) 06:31:34 INFO - PROCESS | 17887 | RSS: Main: 219934720 06:31:34 INFO - PROCESS | 17887 | 06:34:37 INFO - PROCESS | 17887 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-yui.html (next: http://localhost:48987/tests/dromaeo/cssquery-dojo.html) 06:34:37 INFO - PROCESS | 17887 | RSS: Main: 316301312 06:34:37 INFO - PROCESS | 17887 | 06:34:37 INFO - PROCESS | 17887 | __start_tp_report 06:34:37 INFO - PROCESS | 17887 | _x_x_mozilla_page_load 06:34:37 INFO - PROCESS | 17887 | _x_x_mozilla_page_load_details 06:34:37 INFO - PROCESS | 17887 | |i|pagename|runs| 06:34:37 INFO - PROCESS | 17887 | |0;dojo.html;3002.594649722287;3028.7728420368476;3065.3103051813337;3077.6614572397034;3084.429380564597;5125.077486052509;5198.896022079556;5245;5284.548825710754;5318.707471089088;5253.789848406069;5320.9467905321035;5374.301340825697;5385.35375754909;5490.588205884555;4827.058723548909;4852.49048849871;4857.052874689437;4904.926426103611;4925.38432695913;4860.1008813369635;4975.2039673652225;5008.24876268559;5017.824376146836;5043.697378157304;4746.976265118652;4779.235322348408;4966.50334966504;5008.39899212095;5043.218301163289;4825.589824864891;4833.347498087748;4858.659893807435;4890.853274401774;4957.5042495750495;4827.686200396963;4842.346283251751;4872.585830204437;4876.536729010773;4933.975330123327;5374.167004114369;5398.109311963522;5401.4868587484125;5402.78388864445;5406.297181366397;5441.156620723794;5472.699001554913;5575.637583557096;5585.720713964326;5750.942490575125;5686.834198989197;5698.971505142447;5704.201411802351;5757.021306377926;5767.423257674199;5312.548433383167;5319.1223448131395;5321.148616221386;5322.813701520428;5324.707141107277;5640.5487560995025;5649.435056494318;5776.566757493205;5791.886600748412;5868.149118377812;5556.222128901957;5595.936772013304;5613.859653508695;5654.858628534237;5669.659820410789;5618.129189975561;5675.3757086720425;5693.4875861172695;5696.772129114872;5697.088465845445;5488.286522752017;5542.889142217133;5674.4892959633835;5677.091665333527;5677.9211949729415;5610.523105535994;5669.716514174274;5675;5709.771609135588;5773.018586840163;4371.431713877176;4372.759498227628;4376.474823021258;4378.387025816388;4425.159219748238;3830.9042273943373;3894.7078969077434;3911.5501717302304;3935.842566297316;3963.841446342172;5205.089109405839;5336.813211537577;5374.032674118696;5374.758135883816;5384.3000409947235;5617.43825617435;5639.605227634026;5641.661500309994;5645.068563687028;5646.661200327993;5333.893322133536;5357.276767636397;5386.165144402546;5388.084025715638;5448.237246785453;4804.639652026112;4840.878978025507;4847.878803029953;4848.151573474698;4894.486078961729;5649.463300986482;5694.202811606378;5717.656940583578;5722.7424765885635;5778.046622307273;5640.887182256414;5651.124075768263;5653.095504719226;5653.208550802973;5654.943450565442;5736.139579063007;5767.250257466502;5774.913376299275;5777.6822274775295;5778.768849246151;5528.032594295902;5541.418151094238;5543.113101903676;5545.944540554543;5549.472800083986;5674.631148975303;5697.145428185805;5698.629589076697;5699.914501282401;5703.543716502587;5499.917501237404;5522.861928451821;5546.417626149197;5552.3892371839875;5572.86067848307;5552.444755524415;5553.694546799965;5558.861028474321;5560.165975103605;5571.888562228652;5395.865103372447;5462.863428414322;5466;5541.612087153861;5618.044932361427;5566.554675626021;5597.020521408818;5601.887962240651;5648.689322087161;5667.886642267049;5371.248025276386;5419.295491586068;5428.91856622143;5437.211604317431;5438.211459338295 06:34:37 INFO - PROCESS | 17887 | |1;ext.html;589.6992533807758;621.3196549777995;635.3963734452271;636.4240362471965;639.1563136659609;31623.367532649332;32635;32664;35337.2932541349;42138;40831;44734.77632611841;44764;44800.10399792002;44847;8713.651453941851;8876.467411955304;8877.644894204224;8883.333749968746;8883.644654213856;7919.326857217115;8084.393670474708;8511.361647876403;8609.741707748777;10450.425226612571;10522.210834187428;10830.837537436906;10831.079358254558;10836.620718274862;10837.783244335109;10604;10607.416592087433;10610.151187904949;10611.09805666523;10656.840147397796;10386.507238262839;10460.738481537946;10535.84196237057;10559.524821383056;10573.62992295266;41116.38325425121;41273.52358858478;41290.967725807095;41360;41381.172376552604;3238.7085162335266;3276.410246155691;3345.2305969627123;3463.8441270142653;3468.8086959996863;31112.177612470103;31263.57657934679;31895.84052079748;31901.680983190105;31962.680373196203;4224.239636865363;4291;4496.123255965088;4503.572160644733;4536.2741961286365;340143;340328;343668;344609;344733.27633361926;34165.31669366599;35136.47295290573;57267.71366143143;57576.71211643915;57579.424205758245;34819.30361392758;34824.51754824497;34840;34976.30047399038;34987;15372.154531500652;15574.454894078654;15598.220088995506;15608.843911560965;15622.843771562366;13064.608061758163;13192.604221873358;13193.604191874067;13200.47198112084;13202.669933251746;7941.722039728582;8127.2279133482225;8263.917360826435;8579.914200858037;8585.527795971157;3273.4435146025235;3287.1289108386295;3294.489354150063;3323.26888084621;3334.7999120052873;975.3757595139117;978.4862946952907;1001.2840818814583;1032.695354870315;1045.9163266938626;30444.54333185004;30802;30850.382992340026;31194.68805311918;31291.53062704061;1079.3308148947547;1088.50473034769;1108.8115020446544;1138.914581406398;1147.839302497651;15174;15916.76124858128;16172.191390430431;16184.514464566082;16215.675686486204;459581;465110;465977;466398;466657;56048.43951560514;56533;56548.10408178635;56559.71720141373;56644.71677641668;1209.564556759566;1245.5453759377763;1320.1616973222074;1323.3978539764191;1348.0092132282764;27698.584521231794;30657.386852263277;31435;31440.528392074593;32118.83940580282;48132.5186748128;48687;48695;48729.26906096341;48744.34417418637;289259;289891;290215;290496;291505;27288.863555682095;29203.269918252212;29386.55920161242;29609.851950740107;29704.851475742482;45106.77446612746;45791;45863.31205031861;45942.540574593826;46404.30393544032;38907;39044.80477597708;39047;39363.2127357457;40924.1815163701;38660.80669596634;39126.6087339123;39668.603313967644;39706.60293397029;40772.79613601913;38227.42658860064;38447.615523844404;39488.80255598704;39818.80090599528;40081;33403.49894751532;35358.823205883804;35743.46384804178;36450.45324320084;36716.26567468689;26688.866555667097;27263.45473090567;27564.586531201647;27666;27674.44651106926 06:34:37 INFO - PROCESS | 17887 | |2;jquery.html;343.6735101653427;368.3461855207007;375.18397485469114;376.76828750318555;390.84561598168705;14237.501687440928;18801.43595692128;19602.901985490087;19717.605647887034;20435.18259269631;17396.913015434937;18286.908565457186;18429;18482.16830242639;19156.808431915677;5418.376886658036;5694.316681998166;5696.4334807927735;5700.458456446651;5703.600747947646;5444.91832622509;5514.283143191379;5548.472895074981;5560.277163968678;5650.886982260352;5530.751116199761;5536.335639723239;5537.224788529609;5539.667619942797;5540.252065971103;5358.142697168454;5514.972425137868;5536.169574563807;5540.9168862467095;5575.386707462176;4956.058348913695;4956.529129732706;4960.603151747851;4963;4974.054929563371;22274.109035638554;22495.21266755672;22673.886630566907;22679.092836286527;22927.656085158735;2348.835581509295;2399;2431.2463136427764;2520.4581015081662;2994.7871112199596;14812.629684257872;15402.922985385114;15494;15576.766348504781;15576.922115389463;2002.1791065663008;2002.4293076473282;2003.3989803059023;2078.3557097299886;2124.1821898569005;91099.54450227706;92101;93005.53497232537;94160;95466.9999999993;17334.913325433543;17449;18079.36722214716;18164.1826117825;18368.31607939967;30419.19760029996;30443.695563044086;30557.541636875463;30565.541516877263;30584;9910.653127140515;10008.998200359958;10034.19726421899;10256.588072122111;10373.377597344184;8444.746657600283;8484.490930544187;8493.872591911126;8809;8817.823643527221;8601.913980860236;8640.611172497252;8700;8830.91169088301;8915;3112.6264848218357;3375.814330211862;3381.458966565338;3411.300683359905;3430.776999495025;851.9787005324916;870.5342641686667;955.4935883981501;959.9712008639752;969.5782334684435;17980.460586182435;19040.904795475933;19051.904740476486;19102.61794764097;19305.420837374902;927.355487935878;945.2154711589502;945.2485274207022;954.3224310739453;958.8178246133212;9813.460259685644;10758.0855627271;10840;10866.67399978002;10884.183686223565;154385.22807385892;230791;420898;421432;421567;55440;67134;82767.58616206881;83329;84135;1034.6585626743006;1038.6157121864958;1085.5060947268973;1085.9076978456762;1094.485591771866;16577.66844663124;16679.74980375271;16918.32326706967;17400.216990235218;18055.548611284823;38448.80775596104;39084.45951013175;39617.2076558473;40039.79980100081;40469;53956.73021634867;54640.180397293276;55229;55585.16622250588;56620.433795663164;8288.668453261802;8391.66433342684;8405.95797021011;8526.658933642584;8611.95694021526;11814.94092529532;12916.612501624966;12945.482180712666;12980.740385192432;13106.868931310564;11310.208285419942;11371.886281137082;11435.59975400857;11572.30566165999;11666.88333116658;10368.326058806455;10564.04565155418;10699.732506687395;10821.891781082088;10864.837027444437;11039.889601104207;11154.888451115385;11539;11563.6530904073;11940.52237910474;8188.385871059575;8279.793005174677;8364.163583641588;8521.105283945344;8556.57217139128;9738.805223895624;10837.566497340018;11152.776944461228;11281.887181128084;11382.373969431761 06:34:37 INFO - PROCESS | 17887 | |3;mootools.html;1307.4508706343336;1421.5877395555285;1461.9342129604167;1545.8995165314254;1728.7320465327878;6634.70143843527;7685.077790665121;7953.642086106124;7964.960175199123;8075.636596353163;7862.135165131831;7939.603019849013;7939.92060079399;7948.5628290444;7951.44339896206;2197.1540956731656;2241.204372447782;2241.3948233976816;2245.4049676835652;2250.054976909702;2157.978420215801;2232;2234.910603575855;2238.138316748056;2238.6418173092306;2199.1643175593254;2229.843910926236;2238.910443582263;2246.8202543796538;2249.966250506244;2141.0793358855685;2144.1316266911927;2154.9784502154935;2164.404788683109;2169.8698078115285;2190.791874771894;2214.4574579228192;2215.8005779479763;2216.7118274624195;2221.0449506712107;7986.321162701177;8082.313003394718;8103.230193131702;8166.836663266761;8172.550509721963;4873.074115917964;4977.203647416396;4978.850634480935;4984.551390374847;4989.700617962933;3202.6957439043254;3216.3245718399166;3222.323312104461;3267.9673203267903;3291.078498020558;1072;1081.507913899174;1092.126298960828;1123.2530367305733;1129.7062763681502;10839.078678312353;10849.457527123692;10924.453777311182;10936.507857146367;10945.23383363165;4029.6776257899296;4043.8786836394956;4155.958440415558;4160.063985603276;4179.498460184797;8985.685501007434;8988.146126118008;8990.595423205972;8993.595288212045;8993.640254389751;4877.6341774367065;4930.408350997904;4936.48166942473;4937.407511098691;4961.8511444656715;3873.0898238913833;4067.8372865085657;4494.5730155635165;4631.282151266559;4634.328022436728;3474.756767026284;3513.0514761014383;3553.6091029986683;3572.5355703758864;3595.5146055282726;1049.7742985258205;1057.1331508163232;1061.7876424714934;1064.0636240108654;1069.1446842526104;827.3753316246316;911.0843602179767;928.3269629518545;934.4440058165517;956.7416797464784;5448.318960129984;5606.187102870143;5643.915341269884;5784.421557844182;5810.721641238921;921.7188757428914;927.9304052196112;932.7481579973369;955.441066975813;1010.2877471382658;3780.8676696315497;3929.972864236834;3939.6454319110844;3980.7611543307494;3982.303096958021;9319.207867331217;9537.332386733;9540.379875308083;9613.51932403377;9617.51912404377;9475.76310592227;9565.139137477521;9585.760355991157;9589.472579008081;9605.367087595125;7526.6989320427665;7647.388208943271;7678.500897441761;7699.26856948589;7702;5399.784008639767;5479.698616576126;5565.387807341108;5594.664320140804;5704.0588302929555;8699.086595907338;8785.297176226015;8808;9032.696662351058;9072.092790720875;9156.587953541974;9176.35765496409;9213.401128926866;9247.936487304047;9279.118483744034;6257.217847769029;6386.521010924293;7061.223265440694;7180.102487189101;7298.379637730853;7703.114141873756;7880.84238315242;7908.248716371935;7920.84158316842;7944.245296696805;6725.29384414649;6773.898391524032;6879;6894.310568943066;6979;6929.1684997800585;6982.68577913985;7031.824204394727;7062.081929349357;7072.222055573986;6178.969105154445;6293.559450838397;6340.270868850142;6343.4608058313715;6352.396522330371;4684.297355396718;4826.107170173529;4909.4354149273295;5004.024215277986;5025.195968644999;4771.308160316804;4873.415190177201;4972.975135124301;4973.129702302155;5064.139096353555 06:34:37 INFO - PROCESS | 17887 | |4;prototype.html;304.10138042085623;306.8619121395372;314.41048034934505;315.3031799722613;322.6225316379835;5364.812231571891;5390.649607775492;5393.381985404373;5399.406065332811;5429.511343979041;5067.0879241736475;5162.716050617215;5224.406556000418;5246.737663116848;5334.706591137486;4133.318002529594;4164.292640017594;4173.227952828736;4174.31123864562;4177.686673499485;4154.442084218418;4166.0834616384345;4176.665866730655;4188.937165942498;4195.643370313512;3837.808109594523;3921.6470517653406;4062.7156099073077;4113.053997580559;4141.192467468844;4117.958820411817;4127.369688972869;4131.091159944807;4135.441715368417;4151.647109995669;3651.6896063834606;3654.250878569887;3670.7886397488764;3676.466912297702;3677.595464498903;5075.974620126913;5105.285260063594;5109.718965456898;5208.635395522315;5217.895642087175;4693.850006748335;4697.4832768395445;4702.388689470381;4704.717716936961;4727.621790256771;5520.475554822286;5532.75102620383;5544.944550554484;5577.776888924438;5585.933204714282;3895.8636447724193;3973.2450834341385;3993.880183594497;4019.095703466726;4019.307064266948;5656.1798539211995;5671.7447714852515;5694.800681976111;5710.743016564223;5739.225204597367;4044.676425885922;4060.614241647039;4080.224757296104;4083.265012297815;4094.5905409458815;4019.2765302245875;4107.322291821875;4136.524299705572;4167.729097608706;4170.436991006236;4663.650226233046;4677.76611169447;4695.3426520287185;4699.133528547583;4728.338032675429;5551.084071128219;5557.166425036196;5562.332520097614;5569.0254205513875;5597.692126932976;1399.3982587487478;1428.8499707530768;1439.359485029152;1443.718474897406;1446.7323545144181;919.6686399976029;927.5825878354632;928.2666693312208;931.4364809290417;931.6258518684886;4682.508336624674;4736.242201247784;4756.6432517561325;4801.4958429365115;4816.494268101799;4569.405977223007;4948.356713627206;4958.727270000185;5003.123204157624;5036.395632524121;4681.461631912305;4697.459792123881;4752.904941901143;4759.928601070987;4782.91943004787;2666.2134670272317;2673.70589235184;2674.5988101784887;2692.569188929762;2694.7439993200614;5095.770690318945;5153.948460515347;5469.343678758495;5854;5902.734376952962;5781.739821708034;5791.420857914259;5827.213326200908;5828.5337173026055;5839.299284085937;5744.827655170351;5860.2967643883;5879.617824841372;5901.085331773582;5913.704314784243;5667.064934285797;5690.231818704422;5693.117566777156;5716.541886988469;5730.770769169187;5643.573263496736;5653.321601407857;5653.886922261614;5656.660600363992;5697.971510142423;5609.551235901036;5823.301203855564;5851.64890106595;5868.970655146868;5894.38108998549;3980.984848863521;4001.5798341174923;4002.039510517513;4010.3382941814275;4016.4376987221226;5496.615236933376;5546.611737178358;5587.5809314302405;5667.319921609434;5700.629459085146;5546.722663866871;5564.19319198722;5567.192757050286;5582.190582365453;5583.218349431002;5322.308099946982;5518.448155184449;5563.360213575491;5579.386267510652;5589.552835773047;5532.695701736443;5546.944530554642;5576.33084029919;5577;5604.159376093456;5574.9721251393485;5597.804076857454;5625.071863142535;5642.915356269741;5646.745896434588;5201.765920533509;5433.1035379161995;5460.972695136657;5495.862603434946;5573.247611572386 06:34:37 INFO - PROCESS | 17887 | |5;yui.html;714.339236206509;728.2244409703663;742.6472425597839;757.7120694136228;816.9428140030196;12871.613851584456;14406.927965360172;14495.130292182477;14522.346494407751;14743.115413075224;13411.865881341184;13538.932305338483;13550.864491355083;14406.711865762705;14613;770.9421793365506;791.4103992525547;791.6437603078609;791.663542994228;791.8218400859818;650.3593959949446;659.6899457255082;773.1958762886591;800.3797057280595;803.8874557561946;821.4906757810136;832.7918020494876;833.1585099049943;833.6248688090353;833.8415701016818;827.6978902700502;828.7430896422128;829.1956801902176;829.3282441222599;829.6515463505342;494.33018260257194;501.9096562618727;589.9528037756969;601.651042395414;602.5179856115091;13531.729365412637;13902.374393152333;13981.370838312301;14049.71900561983;14061.578152655436;13138.86861131386;13312;13458;13524.391402386818;13528.797068043987;12568.937155314256;12798.552050678274;12856.871431285754;12989.935050324782;13147.276899770508;4326.480822301344;4330.935035974463;4367.803448844809;4375.453068366454;4404.383386325885;48289.034219315414;48588.75705621485;48755;48822.51177488215;52809.47190528084;10448.895511044791;10884.61903833362;10884.891151088546;10981.341119532854;11096.167787415814;18914.716279255823;19015.42953711391;19052.61894762097;19302.903485482482;19397.32109376165;7976.7208147714555;7985.5208687478935;8036.236557527142;8169.673213071529;8224.712135075364;4490.146872094291;4506.414166158378;4533.750643714628;4616;4719.9292010619865;3343.0639420961684;3419.9658003420145;3448.3447944986046;3487.7035451986867;3499.107727529464;591.7514643849594;592.3336246722437;605.3341324542968;606.8543549548077;616.8488720263564;674.5952428542934;702.5293053654065;709.2198581560242;744.1033554566734;747.7756672998079;9374.85937710935;9678.659708871246;9849.803003940024;9858.901410985942;9878.851817222747;622.9501639868799;692.1071817355655;734.3904559215945;748.8202831320552;750.4259241680119;4510.819567217274;4744.264638980963;4918.754062296871;5063.797448102035;5113.181890897438;67728.6613566929;70503.64748176227;70777.2922270781;72457;82290.58854705688;49565.50434495609;50549.24176137361;69881.3011869885;72103.2789672107;78633.60683196547;69631.65184174047;73090.26909731048;73610.63194683992;74758.25241747513;76799.61600191964;9051.502167380857;9054.592543335433;9225.538723063954;9228.169464747936;9427.811443771223;33345.333093338486;35334;38000.80999594984;38983.805080974416;43880.34179487247;47489;68797;69478.31521059868;71531;75000.62499687467;12786;12828.679283017998;12943.158694684815;13138.737225255632;13357.599272021855;13828.446862125402;14105.224212668401;14291.64270893236;14503.347349369093;14608.123512589278;12764.425600847799;13474.52839150625;13681.794773078213;13799.862001379857;13899.096558723651;12974;13372;13444.798328025283;13783.241921694404;14028.649283767987;12753.234805911676;13050;13241.667165937839;13376.197428154343;13604;11158.330500170016;11385.601503947322;11416.94291528537;11437.428128593703;11721.88278117242;11219.66341009771;11255.66233013011;11384.260023098472;11457.484413201593;11471.311721296748 06:34:37 INFO - PROCESS | 17887 | __end_tp_report 06:34:37 INFO - PROCESS | 17887 | __start_cc_report 06:34:37 INFO - PROCESS | 17887 | _x_x_mozilla_cycle_collect,2244 06:34:37 INFO - PROCESS | 17887 | __end_cc_report 06:34:37 INFO - PROCESS | 17887 | __startTimestamp1478180077743__endTimestamp 06:34:37 INFO - PROCESS | 17887 | 06:34:37 INFO - PROCESS | 17887 | ------- Summary: start ------- 06:34:37 INFO - PROCESS | 17887 | Number of tests: 6 06:34:37 INFO - PROCESS | 17887 | 06:34:37 INFO - PROCESS | 17887 | [#0] dojo.html Cycles:165 Average:5272.56 Median:5466.00 stddev:578.70 (10.6%) stddev-sans-first:552.39 06:34:37 INFO - PROCESS | 17887 | Values: 3002.6 3028.8 3065.3 3077.7 3084.4 5125.1 5198.9 5245.0 5284.5 5318.7 5253.8 5320.9 5374.3 5385.4 5490.6 4827.1 4852.5 4857.1 4904.9 4925.4 4860.1 4975.2 5008.2 5017.8 5043.7 4747.0 4779.2 4966.5 5008.4 5043.2 4825.6 4833.3 4858.7 4890.9 4957.5 4827.7 4842.3 4872.6 4876.5 4934.0 5374.2 5398.1 5401.5 5402.8 5406.3 5441.2 5472.7 5575.6 5585.7 5750.9 5686.8 5699.0 5704.2 5757.0 5767.4 5312.5 5319.1 5321.1 5322.8 5324.7 5640.5 5649.4 5776.6 5791.9 5868.1 5556.2 5595.9 5613.9 5654.9 5669.7 5618.1 5675.4 5693.5 5696.8 5697.1 5488.3 5542.9 5674.5 5677.1 5677.9 5610.5 5669.7 5675.0 5709.8 5773.0 4371.4 4372.8 4376.5 4378.4 4425.2 3830.9 3894.7 3911.6 3935.8 3963.8 5205.1 5336.8 5374.0 5374.8 5384.3 5617.4 5639.6 5641.7 5645.1 5646.7 5333.9 5357.3 5386.2 5388.1 5448.2 4804.6 4840.9 4847.9 4848.2 4894.5 5649.5 5694.2 5717.7 5722.7 5778.0 5640.9 5651.1 5653.1 5653.2 5654.9 5736.1 5767.3 5774.9 5777.7 5778.8 5528.0 5541.4 5543.1 5545.9 5549.5 5674.6 5697.1 5698.6 5699.9 5703.5 5499.9 5522.9 5546.4 5552.4 5572.9 5552.4 5553.7 5558.9 5560.2 5571.9 5395.9 5462.9 5466.0 5541.6 5618.0 5566.6 5597.0 5601.9 5648.7 5667.9 5371.2 5419.3 5428.9 5437.2 5438.2 06:34:37 INFO - PROCESS | 17887 | 06:34:37 INFO - PROCESS | 17887 | [#1] ext.html Cycles:180 Average:52025.76 Median:344671.14 stddev:98616.15 (28.6%) stddev-sans-first:98817.18 06:34:37 INFO - PROCESS | 17887 | Values: 589.7 621.3 635.4 636.4 639.2 31623.4 32635.0 32664.0 35337.3 42138.0 40831.0 44734.8 44764.0 44800.1 44847.0 8713.7 8876.5 8877.6 8883.3 8883.6 7919.3 8084.4 8511.4 8609.7 10450.4 10522.2 10830.8 10831.1 10836.6 10837.8 10604.0 10607.4 10610.2 10611.1 10656.8 10386.5 10460.7 10535.8 10559.5 10573.6 41116.4 41273.5 41291.0 41360.0 41381.2 3238.7 3276.4 3345.2 3463.8 3468.8 31112.2 31263.6 31895.8 31901.7 31962.7 4224.2 4291.0 4496.1 4503.6 4536.3 340143.0 340328.0 343668.0 344609.0 344733.3 34165.3 35136.5 57267.7 57576.7 57579.4 34819.3 34824.5 34840.0 34976.3 34987.0 15372.2 15574.5 15598.2 15608.8 15622.8 13064.6 13192.6 13193.6 13200.5 13202.7 7941.7 8127.2 8263.9 8579.9 8585.5 3273.4 3287.1 3294.5 3323.3 3334.8 975.4 978.5 1001.3 1032.7 1045.9 30444.5 30802.0 30850.4 31194.7 31291.5 1079.3 1088.5 1108.8 1138.9 1147.8 15174.0 15916.8 16172.2 16184.5 16215.7 459581.0 465110.0 465977.0 466398.0 466657.0 56048.4 56533.0 56548.1 56559.7 56644.7 1209.6 1245.5 1320.2 1323.4 1348.0 27698.6 30657.4 31435.0 31440.5 32118.8 48132.5 48687.0 48695.0 48729.3 48744.3 289259.0 289891.0 290215.0 290496.0 291505.0 27288.9 29203.3 29386.6 29609.9 29704.9 45106.8 45791.0 45863.3 45942.5 46404.3 38907.0 39044.8 39047.0 39363.2 40924.2 38660.8 39126.6 39668.6 39706.6 40772.8 38227.4 38447.6 39488.8 39818.8 40081.0 33403.5 35358.8 35743.5 36450.5 36716.3 26688.9 27263.5 27564.6 27666.0 27674.4 06:34:37 INFO - PROCESS | 17887 | 06:34:37 INFO - PROCESS | 17887 | [#2] jquery.html Cycles:180 Average:25059.63 Median:3378.64 stddev:58607.63 (1734.7%) stddev-sans-first:58742.66 06:34:37 INFO - PROCESS | 17887 | Values: 343.7 368.3 375.2 376.8 390.8 14237.5 18801.4 19602.9 19717.6 20435.2 17396.9 18286.9 18429.0 18482.2 19156.8 5418.4 5694.3 5696.4 5700.5 5703.6 5444.9 5514.3 5548.5 5560.3 5650.9 5530.8 5536.3 5537.2 5539.7 5540.3 5358.1 5515.0 5536.2 5540.9 5575.4 4956.1 4956.5 4960.6 4963.0 4974.1 22274.1 22495.2 22673.9 22679.1 22927.7 2348.8 2399.0 2431.2 2520.5 2994.8 14812.6 15402.9 15494.0 15576.8 15576.9 2002.2 2002.4 2003.4 2078.4 2124.2 91099.5 92101.0 93005.5 94160.0 95467.0 17334.9 17449.0 18079.4 18164.2 18368.3 30419.2 30443.7 30557.5 30565.5 30584.0 9910.7 10009.0 10034.2 10256.6 10373.4 8444.7 8484.5 8493.9 8809.0 8817.8 8601.9 8640.6 8700.0 8830.9 8915.0 3112.6 3375.8 3381.5 3411.3 3430.8 852.0 870.5 955.5 960.0 969.6 17980.5 19040.9 19051.9 19102.6 19305.4 927.4 945.2 945.2 954.3 958.8 9813.5 10758.1 10840.0 10866.7 10884.2 154385.2 230791.0 420898.0 421432.0 421567.0 55440.0 67134.0 82767.6 83329.0 84135.0 1034.7 1038.6 1085.5 1085.9 1094.5 16577.7 16679.7 16918.3 17400.2 18055.5 38448.8 39084.5 39617.2 40039.8 40469.0 53956.7 54640.2 55229.0 55585.2 56620.4 8288.7 8391.7 8406.0 8526.7 8612.0 11814.9 12916.6 12945.5 12980.7 13106.9 11310.2 11371.9 11435.6 11572.3 11666.9 10368.3 10564.0 10699.7 10821.9 10864.8 11039.9 11154.9 11539.0 11563.7 11940.5 8188.4 8279.8 8364.2 8521.1 8556.6 9738.8 10837.6 11152.8 11281.9 11382.4 06:34:37 INFO - PROCESS | 17887 | 06:34:37 INFO - PROCESS | 17887 | [#3] mootools.html Cycles:180 Average:5276.08 Median:5231.96 stddev:2891.71 (55.3%) stddev-sans-first:2884.44 06:34:37 INFO - PROCESS | 17887 | Values: 1307.5 1421.6 1461.9 1545.9 1728.7 6634.7 7685.1 7953.6 7965.0 8075.6 7862.1 7939.6 7939.9 7948.6 7951.4 2197.2 2241.2 2241.4 2245.4 2250.1 2158.0 2232.0 2234.9 2238.1 2238.6 2199.2 2229.8 2238.9 2246.8 2250.0 2141.1 2144.1 2155.0 2164.4 2169.9 2190.8 2214.5 2215.8 2216.7 2221.0 7986.3 8082.3 8103.2 8166.8 8172.6 4873.1 4977.2 4978.9 4984.6 4989.7 3202.7 3216.3 3222.3 3268.0 3291.1 1072.0 1081.5 1092.1 1123.3 1129.7 10839.1 10849.5 10924.5 10936.5 10945.2 4029.7 4043.9 4156.0 4160.1 4179.5 8985.7 8988.1 8990.6 8993.6 8993.6 4877.6 4930.4 4936.5 4937.4 4961.9 3873.1 4067.8 4494.6 4631.3 4634.3 3474.8 3513.1 3553.6 3572.5 3595.5 1049.8 1057.1 1061.8 1064.1 1069.1 827.4 911.1 928.3 934.4 956.7 5448.3 5606.2 5643.9 5784.4 5810.7 921.7 927.9 932.7 955.4 1010.3 3780.9 3930.0 3939.6 3980.8 3982.3 9319.2 9537.3 9540.4 9613.5 9617.5 9475.8 9565.1 9585.8 9589.5 9605.4 7526.7 7647.4 7678.5 7699.3 7702.0 5399.8 5479.7 5565.4 5594.7 5704.1 8699.1 8785.3 8808.0 9032.7 9072.1 9156.6 9176.4 9213.4 9247.9 9279.1 6257.2 6386.5 7061.2 7180.1 7298.4 7703.1 7880.8 7908.2 7920.8 7944.2 6725.3 6773.9 6879.0 6894.3 6979.0 6929.2 6982.7 7031.8 7062.1 7072.2 6179.0 6293.6 6340.3 6343.5 6352.4 4684.3 4826.1 4909.4 5004.0 5025.2 4771.3 4873.4 4973.0 4973.1 5064.1 06:34:37 INFO - PROCESS | 17887 | 06:34:37 INFO - PROCESS | 17887 | [#4] prototype.html Cycles:180 Average:4602.17 Median:5158.33 stddev:1362.54 (26.4%) stddev-sans-first:1327.62 06:34:37 INFO - PROCESS | 17887 | Values: 304.1 306.9 314.4 315.3 322.6 5364.8 5390.6 5393.4 5399.4 5429.5 5067.1 5162.7 5224.4 5246.7 5334.7 4133.3 4164.3 4173.2 4174.3 4177.7 4154.4 4166.1 4176.7 4188.9 4195.6 3837.8 3921.6 4062.7 4113.1 4141.2 4118.0 4127.4 4131.1 4135.4 4151.6 3651.7 3654.3 3670.8 3676.5 3677.6 5076.0 5105.3 5109.7 5208.6 5217.9 4693.9 4697.5 4702.4 4704.7 4727.6 5520.5 5532.8 5544.9 5577.8 5585.9 3895.9 3973.2 3993.9 4019.1 4019.3 5656.2 5671.7 5694.8 5710.7 5739.2 4044.7 4060.6 4080.2 4083.3 4094.6 4019.3 4107.3 4136.5 4167.7 4170.4 4663.7 4677.8 4695.3 4699.1 4728.3 5551.1 5557.2 5562.3 5569.0 5597.7 1399.4 1428.8 1439.4 1443.7 1446.7 919.7 927.6 928.3 931.4 931.6 4682.5 4736.2 4756.6 4801.5 4816.5 4569.4 4948.4 4958.7 5003.1 5036.4 4681.5 4697.5 4752.9 4759.9 4782.9 2666.2 2673.7 2674.6 2692.6 2694.7 5095.8 5153.9 5469.3 5854.0 5902.7 5781.7 5791.4 5827.2 5828.5 5839.3 5744.8 5860.3 5879.6 5901.1 5913.7 5667.1 5690.2 5693.1 5716.5 5730.8 5643.6 5653.3 5653.9 5656.7 5698.0 5609.6 5823.3 5851.6 5869.0 5894.4 3981.0 4001.6 4002.0 4010.3 4016.4 5496.6 5546.6 5587.6 5667.3 5700.6 5546.7 5564.2 5567.2 5582.2 5583.2 5322.3 5518.4 5563.4 5579.4 5589.6 5532.7 5546.9 5576.3 5577.0 5604.2 5575.0 5597.8 5625.1 5642.9 5646.7 5201.8 5433.1 5461.0 5495.9 5573.2 06:34:37 INFO - PROCESS | 17887 | 06:34:37 INFO - PROCESS | 17887 | [#5] yui.html Cycles:180 Average:16768.22 Median:4732.10 stddev:21270.19 (449.5%) stddev-sans-first:21295.70 06:34:37 INFO - PROCESS | 17887 | Values: 714.3 728.2 742.6 757.7 816.9 12871.6 14406.9 14495.1 14522.3 14743.1 13411.9 13538.9 13550.9 14406.7 14613.0 770.9 791.4 791.6 791.7 791.8 650.4 659.7 773.2 800.4 803.9 821.5 832.8 833.2 833.6 833.8 827.7 828.7 829.2 829.3 829.7 494.3 501.9 590.0 601.7 602.5 13531.7 13902.4 13981.4 14049.7 14061.6 13138.9 13312.0 13458.0 13524.4 13528.8 12568.9 12798.6 12856.9 12989.9 13147.3 4326.5 4330.9 4367.8 4375.5 4404.4 48289.0 48588.8 48755.0 48822.5 52809.5 10448.9 10884.6 10884.9 10981.3 11096.2 18914.7 19015.4 19052.6 19302.9 19397.3 7976.7 7985.5 8036.2 8169.7 8224.7 4490.1 4506.4 4533.8 4616.0 4719.9 3343.1 3420.0 3448.3 3487.7 3499.1 591.8 592.3 605.3 606.9 616.8 674.6 702.5 709.2 744.1 747.8 9374.9 9678.7 9849.8 9858.9 9878.9 623.0 692.1 734.4 748.8 750.4 4510.8 4744.3 4918.8 5063.8 5113.2 67728.7 70503.6 70777.3 72457.0 82290.6 49565.5 50549.2 69881.3 72103.3 78633.6 69631.7 73090.3 73610.6 74758.3 76799.6 9051.5 9054.6 9225.5 9228.2 9427.8 33345.3 35334.0 38000.8 38983.8 43880.3 47489.0 68797.0 69478.3 71531.0 75000.6 12786.0 12828.7 12943.2 13138.7 13357.6 13828.4 14105.2 14291.6 14503.3 14608.1 12764.4 13474.5 13681.8 13799.9 13899.1 12974.0 13372.0 13444.8 13783.2 14028.6 12753.2 13050.0 13241.7 13376.2 13604.0 11158.3 11385.6 11416.9 11437.4 11721.9 11219.7 11255.7 11384.3 11457.5 11471.3 06:34:37 INFO - PROCESS | 17887 | -------- Summary: end -------- 06:34:37 INFO - PROCESS | 17887 | 06:34:38 INFO - TEST-INFO | 17887: exit 0 06:34:38 INFO - TEST-OK | dromaeo_css | took 1117580ms 06:34:38 INFO - TEST-START | kraken 06:34:38 INFO - operating with platform_type : linux_ 06:34:38 INFO - Initialising browser for kraken test... 06:34:38 INFO - TEST-INFO | started process 18198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbIHptB/profile http://localhost:48987/getInfo.html) 06:34:42 INFO - PROCESS | 18198 | __metrics Screen width/height:1600/1200 06:34:42 INFO - PROCESS | 18198 | colorDepth:24 06:34:42 INFO - PROCESS | 18198 | Browser inner width/height: 1024/697 06:34:42 INFO - PROCESS | 18198 | __metrics 06:34:43 INFO - PROCESS | 18198 | 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" 06:34:43 INFO - PROCESS | 18198 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:34:44 INFO - PROCESS | 18198 | console.error: PushService: 06:34:44 INFO - PROCESS | 18198 | stateChangeProcessEnqueue: Error transitioning state 06:34:44 INFO - PROCESS | 18198 | UnknownError 06:34:44 INFO - TEST-INFO | 18198: exit 0 06:34:44 INFO - Browser initialized. 06:34:44 INFO - Running cycle 1/1 for kraken test... 06:34:44 INFO - TEST-INFO | started process 18280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbIHptB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:56 INFO - PROCESS | 18280 | RSS: Main: 173318144 06:34:56 INFO - PROCESS | 18280 | 06:34:59 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-beat-detection) 06:35:00 INFO - PROCESS | 18280 | RSS: Main: 238682112 06:35:00 INFO - PROCESS | 18280 | 06:35:02 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-dft) 06:35:03 INFO - PROCESS | 18280 | RSS: Main: 215789568 06:35:03 INFO - PROCESS | 18280 | 06:35:06 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-fft) 06:35:07 INFO - PROCESS | 18280 | RSS: Main: 298532864 06:35:07 INFO - PROCESS | 18280 | 06:35:09 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-oscillator) 06:35:09 INFO - PROCESS | 18280 | RSS: Main: 207544320 06:35:09 INFO - PROCESS | 18280 | 06:35:11 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48987/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:35:12 INFO - PROCESS | 18280 | RSS: Main: 212209664 06:35:12 INFO - PROCESS | 18280 | 06:35:15 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48987/tests/kraken/driver.html?testName=imaging-darkroom) 06:35:16 INFO - PROCESS | 18280 | RSS: Main: 248270848 06:35:16 INFO - PROCESS | 18280 | 06:35:19 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48987/tests/kraken/driver.html?testName=imaging-desaturate) 06:35:19 INFO - PROCESS | 18280 | RSS: Main: 247537664 06:35:19 INFO - PROCESS | 18280 | 06:35:22 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48987/tests/kraken/driver.html?testName=json-parse-financial) 06:35:23 INFO - PROCESS | 18280 | RSS: Main: 246767616 06:35:23 INFO - PROCESS | 18280 | 06:35:24 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48987/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:25 INFO - PROCESS | 18280 | RSS: Main: 209141760 06:35:25 INFO - PROCESS | 18280 | 06:35:27 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:35:27 INFO - PROCESS | 18280 | RSS: Main: 216260608 06:35:27 INFO - PROCESS | 18280 | 06:35:29 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:30 INFO - PROCESS | 18280 | RSS: Main: 225427456 06:35:30 INFO - PROCESS | 18280 | 06:35:32 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:33 INFO - PROCESS | 18280 | RSS: Main: 234307584 06:35:33 INFO - PROCESS | 18280 | 06:35:36 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:37 INFO - PROCESS | 18280 | RSS: Main: 231239680 06:35:37 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48987/tests/kraken/driver.html?testName=ai-astar) 06:35:38 INFO - PROCESS | 18280 | RSS: Main: 282030080 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | __start_tp_report 06:35:38 INFO - PROCESS | 18280 | _x_x_mozilla_page_load 06:35:38 INFO - PROCESS | 18280 | _x_x_mozilla_page_load_details 06:35:38 INFO - PROCESS | 18280 | |i|pagename|runs| 06:35:38 INFO - PROCESS | 18280 | |0;ai-astar;104;112;113;112;112;113;112;112;113;112 06:35:38 INFO - PROCESS | 18280 | |1;audio-beat-detection;159;122;129;166;125;121;122;133;157;121 06:35:38 INFO - PROCESS | 18280 | |2;audio-dft;161;161;161;160;162;161;162;162;163;160 06:35:38 INFO - PROCESS | 18280 | |3;audio-fft;75;75;76;106;78;78;86;76;98;76 06:35:38 INFO - PROCESS | 18280 | |4;audio-oscillator;83;83;113;82;83;84;102;83;82;109 06:35:38 INFO - PROCESS | 18280 | |5;imaging-gaussian-blur;117;116;116;117;116;117;117;117;117;117 06:35:38 INFO - PROCESS | 18280 | |6;imaging-darkroom;145;147;146;146;145;146;146;146;145;144 06:35:38 INFO - PROCESS | 18280 | |7;imaging-desaturate;84;85;84;84;85;84;84;85;85;84 06:35:38 INFO - PROCESS | 18280 | |8;json-parse-financial;55;54;53;53;55;54;53;56;54;54 06:35:38 INFO - PROCESS | 18280 | |9;json-stringify-tinderbox;60;60;61;59;60;61;60;61;60;60 06:35:38 INFO - PROCESS | 18280 | |10;stanford-crypto-aes;89;81;79;79;80;80;79;80;81;86 06:35:38 INFO - PROCESS | 18280 | |11;stanford-crypto-ccm;135;134;142;136;131;129;138;138;186;141 06:35:38 INFO - PROCESS | 18280 | |12;stanford-crypto-pbkdf2;169;168;166;165;166;167;165;167;164;164 06:35:38 INFO - PROCESS | 18280 | |13;stanford-crypto-sha256-iterative;65;64;64;65;64;64;65;65;65;65 06:35:38 INFO - PROCESS | 18280 | __end_tp_report 06:35:38 INFO - PROCESS | 18280 | __start_cc_report 06:35:38 INFO - PROCESS | 18280 | _x_x_mozilla_cycle_collect,1678 06:35:38 INFO - PROCESS | 18280 | __end_cc_report 06:35:38 INFO - PROCESS | 18280 | __startTimestamp1478180138960__endTimestamp 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | ------- Summary: start ------- 06:35:38 INFO - PROCESS | 18280 | Number of tests: 14 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.68 (2.4%) stddev-sans-first:0.50 06:35:38 INFO - PROCESS | 18280 | Values: 104.0 112.0 113.0 112.0 112.0 113.0 112.0 112.0 113.0 112.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:131.00 stddev:17.91 (13.7%) stddev-sans-first:16.86 06:35:38 INFO - PROCESS | 18280 | Values: 159.0 122.0 129.0 166.0 125.0 121.0 122.0 133.0 157.0 121.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 06:35:38 INFO - PROCESS | 18280 | Values: 161.0 161.0 161.0 160.0 162.0 161.0 162.0 162.0 163.0 160.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:10.98 (14.3%) stddev-sans-first:11.31 06:35:38 INFO - PROCESS | 18280 | Values: 75.0 75.0 76.0 106.0 78.0 78.0 86.0 76.0 98.0 76.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.00 stddev:12.44 (15.0%) stddev-sans-first:12.90 06:35:38 INFO - PROCESS | 18280 | Values: 83.0 83.0 113.0 82.0 83.0 84.0 102.0 83.0 82.0 109.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:35:38 INFO - PROCESS | 18280 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 06:35:38 INFO - PROCESS | 18280 | Values: 145.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 144.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 06:35:38 INFO - PROCESS | 18280 | Values: 84.0 85.0 84.0 84.0 85.0 84.0 84.0 85.0 85.0 84.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.99 (1.8%) stddev-sans-first:1.00 06:35:38 INFO - PROCESS | 18280 | Values: 55.0 54.0 53.0 53.0 55.0 54.0 53.0 56.0 54.0 54.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 06:35:38 INFO - PROCESS | 18280 | Values: 60.0 60.0 61.0 59.0 60.0 61.0 60.0 61.0 60.0 60.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.50 stddev:3.37 (4.2%) stddev-sans-first:2.19 06:35:38 INFO - PROCESS | 18280 | Values: 89.0 81.0 79.0 79.0 80.0 80.0 79.0 80.0 81.0 86.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:138.00 stddev:16.32 (11.8%) stddev-sans-first:17.17 06:35:38 INFO - PROCESS | 18280 | Values: 135.0 134.0 142.0 136.0 131.0 129.0 138.0 138.0 186.0 141.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:166.50 stddev:1.66 (1.0%) stddev-sans-first:1.39 06:35:38 INFO - PROCESS | 18280 | Values: 169.0 168.0 166.0 165.0 166.0 167.0 165.0 167.0 164.0 164.0 06:35:38 INFO - PROCESS | 18280 | 06:35:38 INFO - PROCESS | 18280 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:35:38 INFO - PROCESS | 18280 | Values: 65.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 65.0 06:35:38 INFO - PROCESS | 18280 | -------- Summary: end -------- 06:35:38 INFO - PROCESS | 18280 | 06:35:40 INFO - TEST-INFO | 18280: exit 0 06:35:40 INFO - TEST-OK | kraken | took 61532ms 06:35:40 INFO - SUITE-END | took 1179s 06:35:40 INFO - Completed test suite (00:19:39) 06:35:40 INFO - javascript benchmark 06:35:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3002.594649722287, 3028.7728420368476, 3065.3103051813337, 3077.6614572397034, 3084.429380564597, 5125.077486052509, 5198.896022079556, 5245.0, 5284.548825710754, 5318.707471089088, 5253.789848406069, 5320.9467905321035, 5374.301340825697, 5385.35375754909, 5490.588205884555, 4827.058723548909, 4852.49048849871, 4857.052874689437, 4904.926426103611, 4925.38432695913, 4860.1008813369635, 4975.2039673652225, 5008.24876268559, 5017.824376146836, 5043.697378157304, 4746.976265118652, 4779.235322348408, 4966.50334966504, 5008.39899212095, 5043.218301163289, 4825.589824864891, 4833.347498087748, 4858.659893807435, 4890.853274401774, 4957.5042495750495, 4827.686200396963, 4842.346283251751, 4872.585830204437, 4876.536729010773, 4933.975330123327, 5374.167004114369, 5398.109311963522, 5401.4868587484125, 5402.78388864445, 5406.297181366397, 5441.156620723794, 5472.699001554913, 5575.637583557096, 5585.720713964326, 5750.942490575125, 5686.834198989197, 5698.971505142447, 5704.201411802351, 5757.021306377926, 5767.423257674199, 5312.548433383167, 5319.1223448131395, 5321.148616221386, 5322.813701520428, 5324.707141107277, 5640.5487560995025, 5649.435056494318, 5776.566757493205, 5791.886600748412, 5868.149118377812, 5556.222128901957, 5595.936772013304, 5613.859653508695, 5654.858628534237, 5669.659820410789, 5618.129189975561, 5675.3757086720425, 5693.4875861172695, 5696.772129114872, 5697.088465845445, 5488.286522752017, 5542.889142217133, 5674.4892959633835, 5677.091665333527, 5677.9211949729415, 5610.523105535994, 5669.716514174274, 5675.0, 5709.771609135588, 5773.018586840163, 4371.431713877176, 4372.759498227628, 4376.474823021258, 4378.387025816388, 4425.159219748238, 3830.9042273943373, 3894.7078969077434, 3911.5501717302304, 3935.842566297316, 3963.841446342172, 5205.089109405839, 5336.813211537577, 5374.032674118696, 5374.758135883816, 5384.3000409947235, 5617.43825617435, 5639.605227634026, 5641.661500309994, 5645.068563687028, 5646.661200327993, 5333.893322133536, 5357.276767636397, 5386.165144402546, 5388.084025715638, 5448.237246785453, 4804.639652026112, 4840.878978025507, 4847.878803029953, 4848.151573474698, 4894.486078961729, 5649.463300986482, 5694.202811606378, 5717.656940583578, 5722.7424765885635, 5778.046622307273, 5640.887182256414, 5651.124075768263, 5653.095504719226, 5653.208550802973, 5654.943450565442, 5736.139579063007, 5767.250257466502, 5774.913376299275, 5777.6822274775295, 5778.768849246151, 5528.032594295902, 5541.418151094238, 5543.113101903676, 5545.944540554543, 5549.472800083986, 5674.631148975303, 5697.145428185805, 5698.629589076697, 5699.914501282401, 5703.543716502587, 5499.917501237404, 5522.861928451821, 5546.417626149197, 5552.3892371839875, 5572.86067848307, 5552.444755524415, 5553.694546799965, 5558.861028474321, 5560.165975103605, 5571.888562228652, 5395.865103372447, 5462.863428414322, 5466.0, 5541.612087153861, 5618.044932361427, 5566.554675626021, 5597.020521408818, 5601.887962240651, 5648.689322087161, 5667.886642267049, 5371.248025276386, 5419.295491586068, 5428.91856622143, 5437.211604317431, 5438.211459338295], "value": 5234.255346636365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.6992533807758, 621.3196549777995, 635.3963734452271, 636.4240362471965, 639.1563136659609, 31623.367532649332, 32635.0, 32664.0, 35337.2932541349, 42138.0, 40831.0, 44734.77632611841, 44764.0, 44800.10399792002, 44847.0, 8713.651453941851, 8876.467411955304, 8877.644894204224, 8883.333749968746, 8883.644654213856, 7919.326857217115, 8084.393670474708, 8511.361647876403, 8609.741707748777, 10450.425226612571, 10522.210834187428, 10830.837537436906, 10831.079358254558, 10836.620718274862, 10837.783244335109, 10604.0, 10607.416592087433, 10610.151187904949, 10611.09805666523, 10656.840147397796, 10386.507238262839, 10460.738481537946, 10535.84196237057, 10559.524821383056, 10573.62992295266, 41116.38325425121, 41273.52358858478, 41290.967725807095, 41360.0, 41381.172376552604, 3238.7085162335266, 3276.410246155691, 3345.2305969627123, 3463.8441270142653, 3468.8086959996863, 31112.177612470103, 31263.57657934679, 31895.84052079748, 31901.680983190105, 31962.680373196203, 4224.239636865363, 4291.0, 4496.123255965088, 4503.572160644733, 4536.2741961286365, 340143.0, 340328.0, 343668.0, 344609.0, 344733.27633361926, 34165.31669366599, 35136.47295290573, 57267.71366143143, 57576.71211643915, 57579.424205758245, 34819.30361392758, 34824.51754824497, 34840.0, 34976.30047399038, 34987.0, 15372.154531500652, 15574.454894078654, 15598.220088995506, 15608.843911560965, 15622.843771562366, 13064.608061758163, 13192.604221873358, 13193.604191874067, 13200.47198112084, 13202.669933251746, 7941.722039728582, 8127.2279133482225, 8263.917360826435, 8579.914200858037, 8585.527795971157, 3273.4435146025235, 3287.1289108386295, 3294.489354150063, 3323.26888084621, 3334.7999120052873, 975.3757595139117, 978.4862946952907, 1001.2840818814583, 1032.695354870315, 1045.9163266938626, 30444.54333185004, 30802.0, 30850.382992340026, 31194.68805311918, 31291.53062704061, 1079.3308148947547, 1088.50473034769, 1108.8115020446544, 1138.914581406398, 1147.839302497651, 15174.0, 15916.76124858128, 16172.191390430431, 16184.514464566082, 16215.675686486204, 459581.0, 465110.0, 465977.0, 466398.0, 466657.0, 56048.43951560514, 56533.0, 56548.10408178635, 56559.71720141373, 56644.71677641668, 1209.564556759566, 1245.5453759377763, 1320.1616973222074, 1323.3978539764191, 1348.0092132282764, 27698.584521231794, 30657.386852263277, 31435.0, 31440.528392074593, 32118.83940580282, 48132.5186748128, 48687.0, 48695.0, 48729.26906096341, 48744.34417418637, 289259.0, 289891.0, 290215.0, 290496.0, 291505.0, 27288.863555682095, 29203.269918252212, 29386.55920161242, 29609.851950740107, 29704.851475742482, 45106.77446612746, 45791.0, 45863.31205031861, 45942.540574593826, 46404.30393544032, 38907.0, 39044.80477597708, 39047.0, 39363.2127357457, 40924.1815163701, 38660.80669596634, 39126.6087339123, 39668.603313967644, 39706.60293397029, 40772.79613601913, 38227.42658860064, 38447.615523844404, 39488.80255598704, 39818.80090599528, 40081.0, 33403.49894751532, 35358.823205883804, 35743.46384804178, 36450.45324320084, 36716.26567468689, 26688.866555667097, 27263.45473090567, 27564.586531201647, 27666.0, 27674.44651106926], "value": 18424.559995048283, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.6735101653427, 368.3461855207007, 375.18397485469114, 376.76828750318555, 390.84561598168705, 14237.501687440928, 18801.43595692128, 19602.901985490087, 19717.605647887034, 20435.18259269631, 17396.913015434937, 18286.908565457186, 18429.0, 18482.16830242639, 19156.808431915677, 5418.376886658036, 5694.316681998166, 5696.4334807927735, 5700.458456446651, 5703.600747947646, 5444.91832622509, 5514.283143191379, 5548.472895074981, 5560.277163968678, 5650.886982260352, 5530.751116199761, 5536.335639723239, 5537.224788529609, 5539.667619942797, 5540.252065971103, 5358.142697168454, 5514.972425137868, 5536.169574563807, 5540.9168862467095, 5575.386707462176, 4956.058348913695, 4956.529129732706, 4960.603151747851, 4963.0, 4974.054929563371, 22274.109035638554, 22495.21266755672, 22673.886630566907, 22679.092836286527, 22927.656085158735, 2348.835581509295, 2399.0, 2431.2463136427764, 2520.4581015081662, 2994.7871112199596, 14812.629684257872, 15402.922985385114, 15494.0, 15576.766348504781, 15576.922115389463, 2002.1791065663008, 2002.4293076473282, 2003.3989803059023, 2078.3557097299886, 2124.1821898569005, 91099.54450227706, 92101.0, 93005.53497232537, 94160.0, 95466.9999999993, 17334.913325433543, 17449.0, 18079.36722214716, 18164.1826117825, 18368.31607939967, 30419.19760029996, 30443.695563044086, 30557.541636875463, 30565.541516877263, 30584.0, 9910.653127140515, 10008.998200359958, 10034.19726421899, 10256.588072122111, 10373.377597344184, 8444.746657600283, 8484.490930544187, 8493.872591911126, 8809.0, 8817.823643527221, 8601.913980860236, 8640.611172497252, 8700.0, 8830.91169088301, 8915.0, 3112.6264848218357, 3375.814330211862, 3381.458966565338, 3411.300683359905, 3430.776999495025, 851.9787005324916, 870.5342641686667, 955.4935883981501, 959.9712008639752, 969.5782334684435, 17980.460586182435, 19040.904795475933, 19051.904740476486, 19102.61794764097, 19305.420837374902, 927.355487935878, 945.2154711589502, 945.2485274207022, 954.3224310739453, 958.8178246133212, 9813.460259685644, 10758.0855627271, 10840.0, 10866.67399978002, 10884.183686223565, 154385.22807385892, 230791.0, 420898.0, 421432.0, 421567.0, 55440.0, 67134.0, 82767.58616206881, 83329.0, 84135.0, 1034.6585626743006, 1038.6157121864958, 1085.5060947268973, 1085.9076978456762, 1094.485591771866, 16577.66844663124, 16679.74980375271, 16918.32326706967, 17400.216990235218, 18055.548611284823, 38448.80775596104, 39084.45951013175, 39617.2076558473, 40039.79980100081, 40469.0, 53956.73021634867, 54640.180397293276, 55229.0, 55585.16622250588, 56620.433795663164, 8288.668453261802, 8391.66433342684, 8405.95797021011, 8526.658933642584, 8611.95694021526, 11814.94092529532, 12916.612501624966, 12945.482180712666, 12980.740385192432, 13106.868931310564, 11310.208285419942, 11371.886281137082, 11435.59975400857, 11572.30566165999, 11666.88333116658, 10368.326058806455, 10564.04565155418, 10699.732506687395, 10821.891781082088, 10864.837027444437, 11039.889601104207, 11154.888451115385, 11539.0, 11563.6530904073, 11940.52237910474, 8188.385871059575, 8279.793005174677, 8364.163583641588, 8521.105283945344, 8556.57217139128, 9738.805223895624, 10837.566497340018, 11152.776944461228, 11281.887181128084, 11382.373969431761], "value": 9697.730690227967, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.4508706343336, 1421.5877395555285, 1461.9342129604167, 1545.8995165314254, 1728.7320465327878, 6634.70143843527, 7685.077790665121, 7953.642086106124, 7964.960175199123, 8075.636596353163, 7862.135165131831, 7939.603019849013, 7939.92060079399, 7948.5628290444, 7951.44339896206, 2197.1540956731656, 2241.204372447782, 2241.3948233976816, 2245.4049676835652, 2250.054976909702, 2157.978420215801, 2232.0, 2234.910603575855, 2238.138316748056, 2238.6418173092306, 2199.1643175593254, 2229.843910926236, 2238.910443582263, 2246.8202543796538, 2249.966250506244, 2141.0793358855685, 2144.1316266911927, 2154.9784502154935, 2164.404788683109, 2169.8698078115285, 2190.791874771894, 2214.4574579228192, 2215.8005779479763, 2216.7118274624195, 2221.0449506712107, 7986.321162701177, 8082.313003394718, 8103.230193131702, 8166.836663266761, 8172.550509721963, 4873.074115917964, 4977.203647416396, 4978.850634480935, 4984.551390374847, 4989.700617962933, 3202.6957439043254, 3216.3245718399166, 3222.323312104461, 3267.9673203267903, 3291.078498020558, 1072.0, 1081.507913899174, 1092.126298960828, 1123.2530367305733, 1129.7062763681502, 10839.078678312353, 10849.457527123692, 10924.453777311182, 10936.507857146367, 10945.23383363165, 4029.6776257899296, 4043.8786836394956, 4155.958440415558, 4160.063985603276, 4179.498460184797, 8985.685501007434, 8988.146126118008, 8990.595423205972, 8993.595288212045, 8993.640254389751, 4877.6341774367065, 4930.408350997904, 4936.48166942473, 4937.407511098691, 4961.8511444656715, 3873.0898238913833, 4067.8372865085657, 4494.5730155635165, 4631.282151266559, 4634.328022436728, 3474.756767026284, 3513.0514761014383, 3553.6091029986683, 3572.5355703758864, 3595.5146055282726, 1049.7742985258205, 1057.1331508163232, 1061.7876424714934, 1064.0636240108654, 1069.1446842526104, 827.3753316246316, 911.0843602179767, 928.3269629518545, 934.4440058165517, 956.7416797464784, 5448.318960129984, 5606.187102870143, 5643.915341269884, 5784.421557844182, 5810.721641238921, 921.7188757428914, 927.9304052196112, 932.7481579973369, 955.441066975813, 1010.2877471382658, 3780.8676696315497, 3929.972864236834, 3939.6454319110844, 3980.7611543307494, 3982.303096958021, 9319.207867331217, 9537.332386733, 9540.379875308083, 9613.51932403377, 9617.51912404377, 9475.76310592227, 9565.139137477521, 9585.760355991157, 9589.472579008081, 9605.367087595125, 7526.6989320427665, 7647.388208943271, 7678.500897441761, 7699.26856948589, 7702.0, 5399.784008639767, 5479.698616576126, 5565.387807341108, 5594.664320140804, 5704.0588302929555, 8699.086595907338, 8785.297176226015, 8808.0, 9032.696662351058, 9072.092790720875, 9156.587953541974, 9176.35765496409, 9213.401128926866, 9247.936487304047, 9279.118483744034, 6257.217847769029, 6386.521010924293, 7061.223265440694, 7180.102487189101, 7298.379637730853, 7703.114141873756, 7880.84238315242, 7908.248716371935, 7920.84158316842, 7944.245296696805, 6725.29384414649, 6773.898391524032, 6879.0, 6894.310568943066, 6979.0, 6929.1684997800585, 6982.68577913985, 7031.824204394727, 7062.081929349357, 7072.222055573986, 6178.969105154445, 6293.559450838397, 6340.270868850142, 6343.4608058313715, 6352.396522330371, 4684.297355396718, 4826.107170173529, 4909.4354149273295, 5004.024215277986, 5025.195968644999, 4771.308160316804, 4873.415190177201, 4972.975135124301, 4973.129702302155, 5064.139096353555], "value": 4278.452029306537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.10138042085623, 306.8619121395372, 314.41048034934505, 315.3031799722613, 322.6225316379835, 5364.812231571891, 5390.649607775492, 5393.381985404373, 5399.406065332811, 5429.511343979041, 5067.0879241736475, 5162.716050617215, 5224.406556000418, 5246.737663116848, 5334.706591137486, 4133.318002529594, 4164.292640017594, 4173.227952828736, 4174.31123864562, 4177.686673499485, 4154.442084218418, 4166.0834616384345, 4176.665866730655, 4188.937165942498, 4195.643370313512, 3837.808109594523, 3921.6470517653406, 4062.7156099073077, 4113.053997580559, 4141.192467468844, 4117.958820411817, 4127.369688972869, 4131.091159944807, 4135.441715368417, 4151.647109995669, 3651.6896063834606, 3654.250878569887, 3670.7886397488764, 3676.466912297702, 3677.595464498903, 5075.974620126913, 5105.285260063594, 5109.718965456898, 5208.635395522315, 5217.895642087175, 4693.850006748335, 4697.4832768395445, 4702.388689470381, 4704.717716936961, 4727.621790256771, 5520.475554822286, 5532.75102620383, 5544.944550554484, 5577.776888924438, 5585.933204714282, 3895.8636447724193, 3973.2450834341385, 3993.880183594497, 4019.095703466726, 4019.307064266948, 5656.1798539211995, 5671.7447714852515, 5694.800681976111, 5710.743016564223, 5739.225204597367, 4044.676425885922, 4060.614241647039, 4080.224757296104, 4083.265012297815, 4094.5905409458815, 4019.2765302245875, 4107.322291821875, 4136.524299705572, 4167.729097608706, 4170.436991006236, 4663.650226233046, 4677.76611169447, 4695.3426520287185, 4699.133528547583, 4728.338032675429, 5551.084071128219, 5557.166425036196, 5562.332520097614, 5569.0254205513875, 5597.692126932976, 1399.3982587487478, 1428.8499707530768, 1439.359485029152, 1443.718474897406, 1446.7323545144181, 919.6686399976029, 927.5825878354632, 928.2666693312208, 931.4364809290417, 931.6258518684886, 4682.508336624674, 4736.242201247784, 4756.6432517561325, 4801.4958429365115, 4816.494268101799, 4569.405977223007, 4948.356713627206, 4958.727270000185, 5003.123204157624, 5036.395632524121, 4681.461631912305, 4697.459792123881, 4752.904941901143, 4759.928601070987, 4782.91943004787, 2666.2134670272317, 2673.70589235184, 2674.5988101784887, 2692.569188929762, 2694.7439993200614, 5095.770690318945, 5153.948460515347, 5469.343678758495, 5854.0, 5902.734376952962, 5781.739821708034, 5791.420857914259, 5827.213326200908, 5828.5337173026055, 5839.299284085937, 5744.827655170351, 5860.2967643883, 5879.617824841372, 5901.085331773582, 5913.704314784243, 5667.064934285797, 5690.231818704422, 5693.117566777156, 5716.541886988469, 5730.770769169187, 5643.573263496736, 5653.321601407857, 5653.886922261614, 5656.660600363992, 5697.971510142423, 5609.551235901036, 5823.301203855564, 5851.64890106595, 5868.970655146868, 5894.38108998549, 3980.984848863521, 4001.5798341174923, 4002.039510517513, 4010.3382941814275, 4016.4376987221226, 5496.615236933376, 5546.611737178358, 5587.5809314302405, 5667.319921609434, 5700.629459085146, 5546.722663866871, 5564.19319198722, 5567.192757050286, 5582.190582365453, 5583.218349431002, 5322.308099946982, 5518.448155184449, 5563.360213575491, 5579.386267510652, 5589.552835773047, 5532.695701736443, 5546.944530554642, 5576.33084029919, 5577.0, 5604.159376093456, 5574.9721251393485, 5597.804076857454, 5625.071863142535, 5642.915356269741, 5646.745896434588, 5201.765920533509, 5433.1035379161995, 5460.972695136657, 5495.862603434946, 5573.247611572386], "value": 4164.195005341519, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.339236206509, 728.2244409703663, 742.6472425597839, 757.7120694136228, 816.9428140030196, 12871.613851584456, 14406.927965360172, 14495.130292182477, 14522.346494407751, 14743.115413075224, 13411.865881341184, 13538.932305338483, 13550.864491355083, 14406.711865762705, 14613.0, 770.9421793365506, 791.4103992525547, 791.6437603078609, 791.663542994228, 791.8218400859818, 650.3593959949446, 659.6899457255082, 773.1958762886591, 800.3797057280595, 803.8874557561946, 821.4906757810136, 832.7918020494876, 833.1585099049943, 833.6248688090353, 833.8415701016818, 827.6978902700502, 828.7430896422128, 829.1956801902176, 829.3282441222599, 829.6515463505342, 494.33018260257194, 501.9096562618727, 589.9528037756969, 601.651042395414, 602.5179856115091, 13531.729365412637, 13902.374393152333, 13981.370838312301, 14049.71900561983, 14061.578152655436, 13138.86861131386, 13312.0, 13458.0, 13524.391402386818, 13528.797068043987, 12568.937155314256, 12798.552050678274, 12856.871431285754, 12989.935050324782, 13147.276899770508, 4326.480822301344, 4330.935035974463, 4367.803448844809, 4375.453068366454, 4404.383386325885, 48289.034219315414, 48588.75705621485, 48755.0, 48822.51177488215, 52809.47190528084, 10448.895511044791, 10884.61903833362, 10884.891151088546, 10981.341119532854, 11096.167787415814, 18914.716279255823, 19015.42953711391, 19052.61894762097, 19302.903485482482, 19397.32109376165, 7976.7208147714555, 7985.5208687478935, 8036.236557527142, 8169.673213071529, 8224.712135075364, 4490.146872094291, 4506.414166158378, 4533.750643714628, 4616.0, 4719.9292010619865, 3343.0639420961684, 3419.9658003420145, 3448.3447944986046, 3487.7035451986867, 3499.107727529464, 591.7514643849594, 592.3336246722437, 605.3341324542968, 606.8543549548077, 616.8488720263564, 674.5952428542934, 702.5293053654065, 709.2198581560242, 744.1033554566734, 747.7756672998079, 9374.85937710935, 9678.659708871246, 9849.803003940024, 9858.901410985942, 9878.851817222747, 622.9501639868799, 692.1071817355655, 734.3904559215945, 748.8202831320552, 750.4259241680119, 4510.819567217274, 4744.264638980963, 4918.754062296871, 5063.797448102035, 5113.181890897438, 67728.6613566929, 70503.64748176227, 70777.2922270781, 72457.0, 82290.58854705688, 49565.50434495609, 50549.24176137361, 69881.3011869885, 72103.2789672107, 78633.60683196547, 69631.65184174047, 73090.26909731048, 73610.63194683992, 74758.25241747513, 76799.61600191964, 9051.502167380857, 9054.592543335433, 9225.538723063954, 9228.169464747936, 9427.811443771223, 33345.333093338486, 35334.0, 38000.80999594984, 38983.805080974416, 43880.34179487247, 47489.0, 68797.0, 69478.31521059868, 71531.0, 75000.62499687467, 12786.0, 12828.679283017998, 12943.158694684815, 13138.737225255632, 13357.599272021855, 13828.446862125402, 14105.224212668401, 14291.64270893236, 14503.347349369093, 14608.123512589278, 12764.425600847799, 13474.52839150625, 13681.794773078213, 13799.862001379857, 13899.096558723651, 12974.0, 13372.0, 13444.798328025283, 13783.241921694404, 14028.649283767987, 12753.234805911676, 13050.0, 13241.667165937839, 13376.197428154343, 13604.0, 11158.330500170016, 11385.601503947322, 11416.94291528537, 11437.428128593703, 11721.88278117242, 11219.66341009771, 11255.66233013011, 11384.260023098472, 11457.484413201593, 11471.311721296748], "value": 7028.454927062825, "unit": "score"}], "name": "dromaeo_css", "value": 6994.784714302675, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 122.0, 129.0, 166.0, 125.0, 121.0, 122.0, 133.0, 157.0, 121.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 162.0, 162.0, 163.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 106.0, 78.0, 78.0, 86.0, 76.0, 98.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 82.0, 83.0, 84.0, 102.0, 83.0, 82.0, 109.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 144.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 53.0, 55.0, 54.0, 53.0, 56.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 59.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 79.0, 79.0, 80.0, 80.0, 79.0, 80.0, 81.0, 86.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 142.0, 136.0, 131.0, 129.0, 138.0, 138.0, 186.0, 141.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 166.0, 165.0, 166.0, 167.0, 165.0, 167.0, 164.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1495.2, "alertThreshold": 2.0}]} 06:35:40 INFO - Return code: 0 06:35:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:35:40 INFO - # TBPL SUCCESS # 06:35:40 INFO - Running post-action listener: _resource_record_post_action 06:35:40 INFO - [mozharness: 2016-11-03 13:35:40.765631Z] Finished run-tests step (success) 06:35:40 INFO - Running post-run listener: _resource_record_post_run 06:35:40 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 399491072; Read time: 212; Write time: 312240 06:35:40 INFO - TinderboxPrint: CPU usage
13.0% 06:35:40 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 212 06:35:40 INFO - TinderboxPrint: I/O write bytes / time
399,491,072 / 312,240 06:35:40 INFO - TinderboxPrint: CPU idle
8,303.0 (86.9%) 06:35:40 INFO - TinderboxPrint: CPU user
1,196.8 (12.5%) 06:35:40 INFO - TinderboxPrint: Swap in / out
0 / 0 06:35:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110592000; Read time: 0; Write time: 98592 06:35:40 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288899072; Read time: 200; Write time: 213648 06:35:41 INFO - Running post-run listener: _upload_blobber_files 06:35:41 INFO - Blob upload gear active. 06:35:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:41 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 06:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:35:41 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:35:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:42 INFO - (blobuploader) - INFO - Done attempting. 06:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:35:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:43 INFO - (blobuploader) - INFO - Done attempting. 06:35:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:35:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:35:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:46 INFO - (blobuploader) - INFO - Done attempting. 06:35:46 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:47 INFO - Return code: 0 06:35:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d6baceb49874291f1ea1de271d85a9af6e6543226353fc37b4e0b0e2bb080b5081a318836bde0d458245ba327ae581969f6166f6c04a7787f60e85df342058c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1966e59e588b4286bfb6613fc80ec5bf381ebfe1edee64be481dfd491fcc764321186fcea3f386221a376c334f2dd740b20eae3add3308188615b2702eb6e904", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c158fb9bf684ac4ea5edf97ef3b6928f5773356a24aba2718aecd80407e37d46d2828a67b87f36cff6d5bce2e390adab59be8619aa3f4e20759e4f3c63d036f"} 06:35:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:47 INFO - Contents: 06:35:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d6baceb49874291f1ea1de271d85a9af6e6543226353fc37b4e0b0e2bb080b5081a318836bde0d458245ba327ae581969f6166f6c04a7787f60e85df342058c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1966e59e588b4286bfb6613fc80ec5bf381ebfe1edee64be481dfd491fcc764321186fcea3f386221a376c334f2dd740b20eae3add3308188615b2702eb6e904", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c158fb9bf684ac4ea5edf97ef3b6928f5773356a24aba2718aecd80407e37d46d2828a67b87f36cff6d5bce2e390adab59be8619aa3f4e20759e4f3c63d036f"} 06:35:47 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:47 INFO - Copying logs to upload dir... 06:35:47 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.234224 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-03 06:35:46.520184) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 06:35:46.523579) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d6baceb49874291f1ea1de271d85a9af6e6543226353fc37b4e0b0e2bb080b5081a318836bde0d458245ba327ae581969f6166f6c04a7787f60e85df342058c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1966e59e588b4286bfb6613fc80ec5bf381ebfe1edee64be481dfd491fcc764321186fcea3f386221a376c334f2dd740b20eae3add3308188615b2702eb6e904", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c158fb9bf684ac4ea5edf97ef3b6928f5773356a24aba2718aecd80407e37d46d2828a67b87f36cff6d5bce2e390adab59be8619aa3f4e20759e4f3c63d036f"} build_url:https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011139 build_url: 'https://queue.taskcluster.net/v1/task/O7eCoIkNRvy61ZbV7gYgOw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d6baceb49874291f1ea1de271d85a9af6e6543226353fc37b4e0b0e2bb080b5081a318836bde0d458245ba327ae581969f6166f6c04a7787f60e85df342058c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1966e59e588b4286bfb6613fc80ec5bf381ebfe1edee64be481dfd491fcc764321186fcea3f386221a376c334f2dd740b20eae3add3308188615b2702eb6e904", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c158fb9bf684ac4ea5edf97ef3b6928f5773356a24aba2718aecd80407e37d46d2828a67b87f36cff6d5bce2e390adab59be8619aa3f4e20759e4f3c63d036f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 06:35:46.548786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:35:46.549156) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1478178905.21017-2000660098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:35:46.633991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 06:35:46.634314) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 06:35:46.634619) ========= ========= Total master_lag: 0.16 =========