builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1475642287.57 results: success (0) buildid: 20161004183012 builduid: c68dad5f1a0044e0ab0e39d2debedc38 revision: ea104eeb14cc54da9a06c3766da63f73117723a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:07.566423) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:07.567417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:07.568080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:07.583644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:07.584010) ========= 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=41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 21:38:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.6M=0s 2016-10-04 21:38:07 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.292814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:07.891087) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:07.891475) ========= 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=41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020361 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:07.941930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:07.942368) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea104eeb14cc54da9a06c3766da63f73117723a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ea104eeb14cc54da9a06c3766da63f73117723a0 --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=41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 21:38:08,037 truncating revision to first 12 chars 2016-10-04 21:38:08,037 Setting DEBUG logging. 2016-10-04 21:38:08,037 attempt 1/10 2016-10-04 21:38:08,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea104eeb14cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 21:38:08,352 unpacking tar archive at: fx-team-ea104eeb14cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640183 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:08.597081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:08.597470) ========= script_repo_revision: ea104eeb14cc54da9a06c3766da63f73117723a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:08.597936) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:08.598462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 21:38:08.608356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-04 21:38:08.608718) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:38:08 INFO - MultiFileLogger online at 20161004 21:38:08 in /builds/slave/test 21:38:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:38:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:38:08 INFO - {'append_to_log': False, 21:38:08 INFO - 'base_work_dir': '/builds/slave/test', 21:38:08 INFO - 'blob_upload_branch': 'Fx-Team', 21:38:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:38:08 INFO - 'branch': 'Fx-Team', 21:38:08 INFO - 'buildbot_json_path': 'buildprops.json', 21:38:08 INFO - 'config_files': ('talos/linux_config.py',), 21:38:08 INFO - 'default_actions': ('clobber', 21:38:08 INFO - 'read-buildbot-config', 21:38:08 INFO - 'download-and-extract', 21:38:08 INFO - 'populate-webroot', 21:38:08 INFO - 'create-virtualenv', 21:38:08 INFO - 'install', 21:38:08 INFO - 'run-tests'), 21:38:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:38:08 INFO - 'download_minidump_stackwalk': True, 21:38:08 INFO - 'download_symbols': 'ondemand', 21:38:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:38:08 INFO - 'tooltool.py': '/tools/tooltool.py', 21:38:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:38:08 INFO - '/tools/misc-python/virtualenv.py')}, 21:38:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:38:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:38:08 INFO - 'installer_path': 'installer.exe', 21:38:08 INFO - 'log_level': 'info', 21:38:08 INFO - 'log_name': 'talos', 21:38:08 INFO - 'log_to_console': True, 21:38:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:38:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:38:08 INFO - 'opt_config_files': (), 21:38:08 INFO - 'pip_index': False, 21:38:08 INFO - 'sps_profile': False, 21:38:08 INFO - 'sps_profile_interval': 0, 21:38:08 INFO - 'suite': 'dromaeojs', 21:38:08 INFO - 'system_bits': '32', 21:38:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:38:08 INFO - 'title': 'talos-linux64-ix-026', 21:38:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:38:08 INFO - 'use_talos_json': True, 21:38:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:38:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:38:08 INFO - 'work_dir': 'build'} 21:38:08 INFO - [mozharness: 2016-10-05 04:38:08.791048Z] Running clobber step. 21:38:08 INFO - Running pre-action listener: _resource_record_pre_action 21:38:08 INFO - Running main action method: clobber 21:38:08 INFO - rmtree: /builds/slave/test/build 21:38:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:38:09 INFO - Running post-action listener: _resource_record_post_action 21:38:09 INFO - [mozharness: 2016-10-05 04:38:09.259728Z] Finished clobber step (success) 21:38:09 INFO - [mozharness: 2016-10-05 04:38:09.259831Z] Running read-buildbot-config step. 21:38:09 INFO - Running pre-action listener: _resource_record_pre_action 21:38:09 INFO - Running main action method: read_buildbot_config 21:38:09 INFO - Using buildbot properties: 21:38:09 INFO - { 21:38:09 INFO - "project": "", 21:38:09 INFO - "product": "firefox", 21:38:09 INFO - "script_repo_revision": "production", 21:38:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:38:09 INFO - "repository": "", 21:38:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:38:09 INFO - "buildid": "20161004183012", 21:38:09 INFO - "pgo_build": "True", 21:38:09 INFO - "basedir": "/builds/slave/test", 21:38:09 INFO - "buildnumber": 504, 21:38:09 INFO - "slavename": "talos-linux64-ix-026", 21:38:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:38:09 INFO - "platform": "ubuntu64_hw", 21:38:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:38:09 INFO - "branch": "fx-team", 21:38:09 INFO - "repo_path": "integration/fx-team", 21:38:09 INFO - "revision": "ea104eeb14cc54da9a06c3766da63f73117723a0", 21:38:09 INFO - "stage_platform": "linux64-pgo", 21:38:09 INFO - "builduid": "c68dad5f1a0044e0ab0e39d2debedc38", 21:38:09 INFO - "slavebuilddir": "test" 21:38:09 INFO - } 21:38:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:38:09 INFO - Running post-action listener: _resource_record_post_action 21:38:09 INFO - [mozharness: 2016-10-05 04:38:09.262264Z] Finished read-buildbot-config step (success) 21:38:09 INFO - [mozharness: 2016-10-05 04:38:09.262353Z] Running download-and-extract step. 21:38:09 INFO - Running pre-action listener: _resource_record_pre_action 21:38:09 INFO - Running main action method: download_and_extract 21:38:09 INFO - mkdir: /builds/slave/test/build/tests 21:38:09 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')]} 21:38:09 INFO - trying https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:38:09 INFO - Downloading https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/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 21:38:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/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 21:38:09 INFO - Downloaded 1361 bytes. 21:38:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:38:09 INFO - Using the following test package requirements: 21:38:09 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:38:09 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:38:09 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:38:09 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:09 INFO - u'jsshell-linux-x86_64.zip'], 21:38:09 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:38:09 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:38:09 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:38:09 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:38:09 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:38:09 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:38:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:38:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:38:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:38:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:38:09 INFO - Fetch https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:38:10 INFO - Http code: 200 21:38:10 INFO - via: 1.1 296faebadd40feee8b2eb0e10d5786d2.cloudfront.net (CloudFront) 21:38:10 INFO - x-amz-cf-id: 10zDbIOa_OnuMC_3-8geTJ612WJ9SjgkpZlSm_GtOJOfRb0mhh6LEA== 21:38:10 INFO - x-amz-version-id: TjFMFZva8VLRdiFY1zlkCM6Ouo5chA2R 21:38:10 INFO - Expected file size: 21992819 21:38:10 INFO - Obtained file size: 21992819 21:38:14 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 21:38:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:38:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:38:14 INFO - Fetch https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:38:15 INFO - Http code: 200 21:38:15 INFO - via: 1.1 55676da1e5c0a9c4e60a94a95b01dc04.cloudfront.net (CloudFront) 21:38:15 INFO - x-amz-cf-id: a4Lp8G1pnWq_W2iDX_ej4HhBoJ3pKSH4PyzD1fUPP7no1OTnveBaxQ== 21:38:15 INFO - x-amz-version-id: TjFMFZva8VLRdiFY1zlkCM6Ouo5chA2R 21:38:15 INFO - Expected file size: 21992819 21:38:15 INFO - Obtained file size: 21992819 21:38:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:38:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:38:19 INFO - Fetch https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:38:20 INFO - Http code: 200 21:38:20 INFO - via: 1.1 30bb04916f91d64c600e15c15000042d.cloudfront.net (CloudFront) 21:38:20 INFO - x-amz-cf-id: eEQX3DgyFHP6e6W12PNs4dZ2_aLCbme0XZVzR2ozzI3ggcB61qLeOA== 21:38:20 INFO - x-amz-version-id: 2YI2oxxCwR1mKNtF4TjZLozg0tDuIgqR 21:38:20 INFO - Expected file size: 14409006 21:38:20 INFO - Obtained file size: 14409006 21:38:20 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')]} 21:38:20 INFO - trying https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:38:20 INFO - Downloading https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/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 21:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/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 21:38:22 INFO - Downloaded 59706709 bytes. 21:38:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:38:22 INFO - mkdir: /builds/slave/test/properties 21:38:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:38:22 INFO - Writing to file /builds/slave/test/properties/build_url 21:38:22 INFO - Contents: 21:38:22 INFO - build_url:https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:38:22 INFO - Running post-action listener: _resource_record_post_action 21:38:22 INFO - Running post-action listener: set_extra_try_arguments 21:38:22 INFO - [mozharness: 2016-10-05 04:38:22.788863Z] Finished download-and-extract step (success) 21:38:22 INFO - [mozharness: 2016-10-05 04:38:22.789092Z] Running populate-webroot step. 21:38:22 INFO - Running pre-action listener: _resource_record_pre_action 21:38:22 INFO - Running main action method: populate_webroot 21:38:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:38:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:38:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:38:22 INFO - '--tppagecycles', 21:38:22 INFO - '7'], 21:38:22 INFO - 'tests': ['tsvgm']}}, 21:38:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:38:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:38:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:38:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:38:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:22 INFO - 'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:22 INFO - 'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['damp', 'tps']}, 21:38:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:22 INFO - 'tests': ['damp', 'tps']}, 21:38:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['dromaeo_dom']}, 21:38:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:38:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['basic_compositor_video']}, 21:38:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:38:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['a11yr', 21:38:22 INFO - 'ts_paint', 21:38:22 INFO - 'tpaint', 21:38:22 INFO - 'sessionrestore', 21:38:22 INFO - 'sessionrestore_no_auto_restore', 21:38:22 INFO - 'tabpaint']}, 21:38:22 INFO - 'other-e10s': {'tests': ['a11yr', 21:38:22 INFO - 'ts_paint', 21:38:22 INFO - 'tpaint', 21:38:22 INFO - 'sessionrestore', 21:38:22 INFO - 'sessionrestore_no_auto_restore', 21:38:22 INFO - 'tabpaint']}, 21:38:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:38:22 INFO - 'ts_paint', 21:38:22 INFO - 'tpaint', 21:38:22 INFO - 'sessionrestore', 21:38:22 INFO - 'sessionrestore_no_auto_restore', 21:38:22 INFO - 'tabpaint']}, 21:38:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:38:22 INFO - 'ts_paint', 21:38:22 INFO - 'tpaint', 21:38:22 INFO - 'sessionrestore', 21:38:22 INFO - 'sessionrestore_no_auto_restore', 21:38:22 INFO - 'tabpaint']}, 21:38:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['a11yr', 21:38:22 INFO - 'ts_paint', 21:38:22 INFO - 'tpaint', 21:38:22 INFO - 'sessionrestore', 21:38:22 INFO - 'sessionrestore_no_auto_restore', 21:38:22 INFO - 'tabpaint']}, 21:38:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['a11yr', 21:38:22 INFO - 'ts_paint', 21:38:22 INFO - 'tpaint', 21:38:22 INFO - 'sessionrestore', 21:38:22 INFO - 'sessionrestore_no_auto_restore', 21:38:22 INFO - 'tabpaint']}, 21:38:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['tsvgx', 21:38:22 INFO - 'tsvgr_opacity', 21:38:22 INFO - 'tart', 21:38:22 INFO - 'tscrollx', 21:38:22 INFO - 'cart']}, 21:38:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:38:22 INFO - 'tsvgr_opacity', 21:38:22 INFO - 'tart', 21:38:22 INFO - 'tscrollx', 21:38:22 INFO - 'cart']}, 21:38:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:22 INFO - 'talos_options': ['--disable-e10s'], 21:38:22 INFO - 'tests': ['tp5o']}, 21:38:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:22 INFO - 'tests': ['tp5o']}, 21:38:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:22 INFO - 'talos_options': ['--disable-e10s', 21:38:22 INFO - '--xperf_path', 21:38:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:22 INFO - 'tests': ['tp5n']}, 21:38:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:22 INFO - 'talos_options': ['--xperf_path', 21:38:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:22 INFO - 'tests': ['tp5n']}}, 21:38:22 INFO - 'talos.zip': {'path': '', 21:38:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:38:22 INFO - Running post-action listener: _resource_record_post_action 21:38:22 INFO - [mozharness: 2016-10-05 04:38:22.810920Z] Finished populate-webroot step (success) 21:38:22 INFO - [mozharness: 2016-10-05 04:38:22.811009Z] Running create-virtualenv step. 21:38:22 INFO - Running pre-action listener: _resource_record_pre_action 21:38:22 INFO - Running main action method: create_virtualenv 21:38:22 INFO - Creating virtualenv /builds/slave/test/build/venv 21:38:22 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 21:38:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:38:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:38:22 INFO - Using real prefix '/usr' 21:38:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:38:23 INFO - Installing distribute.............................................................................................................................................................................................done. 21:38:25 INFO - Installing pip.................done. 21:38:25 INFO - Return code: 0 21:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:38:25 INFO - Reading from file tmpfile_stdout 21:38:25 INFO - Output received: 21:38:25 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) 21:38:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:38:25 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')]} 21:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:25 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')]} 21:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:25 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 0x7fe729b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, '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': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', '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 21:38:25 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 21:38:25 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 21:38:25 INFO - Using env: {'DISPLAY': ':0', 21:38:25 INFO - 'HOME': '/home/cltbld', 21:38:25 INFO - 'LANG': 'en_US.UTF-8', 21:38:25 INFO - 'LANGUAGE': 'en_US:en', 21:38:25 INFO - 'LOGNAME': 'cltbld', 21:38:25 INFO - 'MAIL': '/var/mail/cltbld', 21:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:25 INFO - 'MOZ_NO_REMOTE': '1', 21:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:25 INFO - 'NO_EM_RESTART': '1', 21:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:25 INFO - 'PWD': '/builds/slave/test', 21:38:25 INFO - 'SHELL': '/bin/bash', 21:38:25 INFO - 'SHLVL': '1', 21:38:25 INFO - 'TERM': 'linux', 21:38:25 INFO - 'TMOUT': '86400', 21:38:25 INFO - 'USER': 'cltbld', 21:38:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:25 INFO - '_': '/tools/buildbot/bin/python'} 21:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:25 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 21:38:25 INFO - Cleaning up... 21:38:25 INFO - Return code: 0 21:38:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:38:25 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')]} 21:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:25 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')]} 21:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:25 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 0x7fe729b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, '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': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', '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 21:38:25 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 21:38:25 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 21:38:25 INFO - Using env: {'DISPLAY': ':0', 21:38:25 INFO - 'HOME': '/home/cltbld', 21:38:25 INFO - 'LANG': 'en_US.UTF-8', 21:38:25 INFO - 'LANGUAGE': 'en_US:en', 21:38:25 INFO - 'LOGNAME': 'cltbld', 21:38:25 INFO - 'MAIL': '/var/mail/cltbld', 21:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:25 INFO - 'MOZ_NO_REMOTE': '1', 21:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:25 INFO - 'NO_EM_RESTART': '1', 21:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:25 INFO - 'PWD': '/builds/slave/test', 21:38:25 INFO - 'SHELL': '/bin/bash', 21:38:25 INFO - 'SHLVL': '1', 21:38:25 INFO - 'TERM': 'linux', 21:38:25 INFO - 'TMOUT': '86400', 21:38:25 INFO - 'USER': 'cltbld', 21:38:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:25 INFO - '_': '/tools/buildbot/bin/python'} 21:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:26 INFO - Downloading/unpacking psutil>=3.1.1 21:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:38:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:28 INFO - Installing collected packages: psutil 21:38:28 INFO - Running setup.py install for psutil 21:38:28 INFO - building 'psutil._psutil_linux' extension 21:38:28 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 21:38:28 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 21:38:28 INFO - building 'psutil._psutil_posix' extension 21:38:28 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 21:38:28 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 21:38:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:28 INFO - Successfully installed psutil 21:38:28 INFO - Cleaning up... 21:38:28 INFO - Return code: 0 21:38:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:38:28 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')]} 21:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:28 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')]} 21:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:28 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 0x7fe729b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, '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': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', '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 21:38:28 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 21:38:28 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 21:38:28 INFO - Using env: {'DISPLAY': ':0', 21:38:28 INFO - 'HOME': '/home/cltbld', 21:38:28 INFO - 'LANG': 'en_US.UTF-8', 21:38:28 INFO - 'LANGUAGE': 'en_US:en', 21:38:28 INFO - 'LOGNAME': 'cltbld', 21:38:28 INFO - 'MAIL': '/var/mail/cltbld', 21:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:28 INFO - 'MOZ_NO_REMOTE': '1', 21:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:28 INFO - 'NO_EM_RESTART': '1', 21:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:28 INFO - 'PWD': '/builds/slave/test', 21:38:28 INFO - 'SHELL': '/bin/bash', 21:38:28 INFO - 'SHLVL': '1', 21:38:28 INFO - 'TERM': 'linux', 21:38:28 INFO - 'TMOUT': '86400', 21:38:28 INFO - 'USER': 'cltbld', 21:38:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:28 INFO - '_': '/tools/buildbot/bin/python'} 21:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:38:28 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 21:38:28 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 21:38:28 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 21:38:28 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 21:38:28 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 21:38:28 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 21:38:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:38:30 INFO - Installing collected packages: mozsystemmonitor 21:38:30 INFO - Running setup.py install for mozsystemmonitor 21:38:30 INFO - Successfully installed mozsystemmonitor 21:38:30 INFO - Cleaning up... 21:38:30 INFO - Return code: 0 21:38:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:30 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 0x7fe729b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, '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': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', '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 21:38:30 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 21:38:30 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 21:38:30 INFO - Using env: {'DISPLAY': ':0', 21:38:30 INFO - 'HOME': '/home/cltbld', 21:38:30 INFO - 'LANG': 'en_US.UTF-8', 21:38:30 INFO - 'LANGUAGE': 'en_US:en', 21:38:30 INFO - 'LOGNAME': 'cltbld', 21:38:30 INFO - 'MAIL': '/var/mail/cltbld', 21:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:30 INFO - 'MOZ_NO_REMOTE': '1', 21:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:30 INFO - 'NO_EM_RESTART': '1', 21:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:30 INFO - 'PWD': '/builds/slave/test', 21:38:30 INFO - 'SHELL': '/bin/bash', 21:38:30 INFO - 'SHLVL': '1', 21:38:30 INFO - 'TERM': 'linux', 21:38:30 INFO - 'TMOUT': '86400', 21:38:30 INFO - 'USER': 'cltbld', 21:38:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:31 INFO - '_': '/tools/buildbot/bin/python'} 21:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:31 INFO - Downloading/unpacking jsonschema==2.5.1 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:38:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:38:33 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 21:38:33 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 21:38:33 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 21:38:33 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 21:38:33 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 21:38:33 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 21:38:33 INFO - Downloading functools32-3.2.3-2.tar.gz 21:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:38:33 INFO - warning: no files found matching '*.txt' 21:38:33 INFO - no previously-included directories found matching 'build' 21:38:33 INFO - no previously-included directories found matching 'dist' 21:38:33 INFO - no previously-included directories found matching '.git*' 21:38:33 INFO - Installing collected packages: jsonschema, functools32 21:38:33 INFO - Running setup.py install for functools32 21:38:33 INFO - warning: no files found matching '*.txt' 21:38:33 INFO - no previously-included directories found matching 'build' 21:38:33 INFO - no previously-included directories found matching 'dist' 21:38:33 INFO - no previously-included directories found matching '.git*' 21:38:33 INFO - Successfully installed jsonschema functools32 21:38:33 INFO - Cleaning up... 21:38:33 INFO - Return code: 0 21:38:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:33 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 0x7fe729b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, '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': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', '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 21:38:33 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 21:38:33 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 21:38:33 INFO - Using env: {'DISPLAY': ':0', 21:38:33 INFO - 'HOME': '/home/cltbld', 21:38:33 INFO - 'LANG': 'en_US.UTF-8', 21:38:33 INFO - 'LANGUAGE': 'en_US:en', 21:38:33 INFO - 'LOGNAME': 'cltbld', 21:38:33 INFO - 'MAIL': '/var/mail/cltbld', 21:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:33 INFO - 'MOZ_NO_REMOTE': '1', 21:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:33 INFO - 'NO_EM_RESTART': '1', 21:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:33 INFO - 'PWD': '/builds/slave/test', 21:38:33 INFO - 'SHELL': '/bin/bash', 21:38:33 INFO - 'SHLVL': '1', 21:38:33 INFO - 'TERM': 'linux', 21:38:33 INFO - 'TMOUT': '86400', 21:38:33 INFO - 'USER': 'cltbld', 21:38:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:33 INFO - '_': '/tools/buildbot/bin/python'} 21:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:38:33 INFO - Cleaning up... 21:38:33 INFO - Return code: 0 21:38:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:33 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 0x7fe729b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, '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': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', '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 21:38:33 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 21:38:33 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 21:38:33 INFO - Using env: {'DISPLAY': ':0', 21:38:33 INFO - 'HOME': '/home/cltbld', 21:38:33 INFO - 'LANG': 'en_US.UTF-8', 21:38:33 INFO - 'LANGUAGE': 'en_US:en', 21:38:33 INFO - 'LOGNAME': 'cltbld', 21:38:33 INFO - 'MAIL': '/var/mail/cltbld', 21:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:33 INFO - 'MOZ_NO_REMOTE': '1', 21:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:33 INFO - 'NO_EM_RESTART': '1', 21:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:33 INFO - 'PWD': '/builds/slave/test', 21:38:33 INFO - 'SHELL': '/bin/bash', 21:38:33 INFO - 'SHLVL': '1', 21:38:33 INFO - 'TERM': 'linux', 21:38:33 INFO - 'TMOUT': '86400', 21:38:33 INFO - 'USER': 'cltbld', 21:38:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:33 INFO - '_': '/tools/buildbot/bin/python'} 21:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:33 INFO - Downloading/unpacking blobuploader==1.2.4 21:38:33 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 21:38:33 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 21:38:33 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 21:38:33 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 21:38:33 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 21:38:33 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 21:38:35 INFO - Downloading blobuploader-1.2.4.tar.gz 21:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:38:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38: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 21:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:38:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:38:36 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 21:38:36 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 21:38:36 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 21:38:36 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 21:38:36 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 21:38:36 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 21:38:36 INFO - Downloading docopt-0.6.1.tar.gz 21:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:38:36 INFO - Installing collected packages: blobuploader, requests, docopt 21:38:36 INFO - Running setup.py install for blobuploader 21:38:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:38:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:38:36 INFO - Running setup.py install for requests 21:38:37 INFO - Running setup.py install for docopt 21:38:37 INFO - Successfully installed blobuploader requests docopt 21:38:37 INFO - Cleaning up... 21:38:37 INFO - Return code: 0 21:38:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:37 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 0x7fe729b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, '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': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', '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 21:38:37 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 21:38:37 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 21:38:37 INFO - Using env: {'DISPLAY': ':0', 21:38:37 INFO - 'HOME': '/home/cltbld', 21:38:37 INFO - 'LANG': 'en_US.UTF-8', 21:38:37 INFO - 'LANGUAGE': 'en_US:en', 21:38:37 INFO - 'LOGNAME': 'cltbld', 21:38:37 INFO - 'MAIL': '/var/mail/cltbld', 21:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:37 INFO - 'MOZ_NO_REMOTE': '1', 21:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:37 INFO - 'NO_EM_RESTART': '1', 21:38:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:37 INFO - 'PWD': '/builds/slave/test', 21:38:37 INFO - 'SHELL': '/bin/bash', 21:38:37 INFO - 'SHLVL': '1', 21:38:37 INFO - 'TERM': 'linux', 21:38:37 INFO - 'TMOUT': '86400', 21:38:37 INFO - 'USER': 'cltbld', 21:38:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:37 INFO - '_': '/tools/buildbot/bin/python'} 21:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:37 INFO - Running setup.py (path:/tmp/pip-UhrVLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:37 INFO - Running setup.py (path:/tmp/pip-mCRySN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:37 INFO - Running setup.py (path:/tmp/pip-SyoTuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:37 INFO - Running setup.py (path:/tmp/pip-ZEbla1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:37 INFO - Running setup.py (path:/tmp/pip-FBF6SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:37 INFO - Running setup.py (path:/tmp/pip-EXvz7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:37 INFO - Running setup.py (path:/tmp/pip-H1K5QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:37 INFO - Running setup.py (path:/tmp/pip-NHkkQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:38 INFO - Running setup.py (path:/tmp/pip-f_k2I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:38 INFO - Running setup.py (path:/tmp/pip-9PVBXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:38 INFO - Running setup.py (path:/tmp/pip-3H3o9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:38 INFO - Running setup.py (path:/tmp/pip-LFYFRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:38 INFO - Running setup.py (path:/tmp/pip-SBRrmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:38 INFO - Running setup.py (path:/tmp/pip-q4zrVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:38 INFO - Running setup.py (path:/tmp/pip-SO1u3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:38 INFO - Running setup.py (path:/tmp/pip-kxs_Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:38 INFO - Running setup.py (path:/tmp/pip-KkpvBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:38:38 INFO - Running setup.py install for manifestparser 21:38:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:38:38 INFO - Running setup.py install for mozcrash 21:38:38 INFO - Running setup.py install for mozdebug 21:38:39 INFO - Running setup.py install for mozdevice 21:38:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:38:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:38:39 INFO - Running setup.py install for mozfile 21:38:39 INFO - Running setup.py install for mozhttpd 21:38:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:38:39 INFO - Running setup.py install for mozinfo 21:38:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:38:39 INFO - Running setup.py install for mozInstall 21:38:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:38:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:38:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:38:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:38:39 INFO - Running setup.py install for mozleak 21:38:39 INFO - Running setup.py install for mozlog 21:38:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:38:39 INFO - Running setup.py install for moznetwork 21:38:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:38:39 INFO - Running setup.py install for mozprocess 21:38:39 INFO - Running setup.py install for mozprofile 21:38:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:38:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:38:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:38:40 INFO - Running setup.py install for mozrunner 21:38:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:38:40 INFO - Running setup.py install for mozscreenshot 21:38:40 INFO - Running setup.py install for moztest 21:38:40 INFO - Running setup.py install for mozversion 21:38:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:38:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:38:40 INFO - Cleaning up... 21:38:40 INFO - Return code: 0 21:38:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:40 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 0x7fe729b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, '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': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', '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 21:38:40 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 21:38:40 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 21:38:40 INFO - Using env: {'DISPLAY': ':0', 21:38:40 INFO - 'HOME': '/home/cltbld', 21:38:40 INFO - 'LANG': 'en_US.UTF-8', 21:38:40 INFO - 'LANGUAGE': 'en_US:en', 21:38:40 INFO - 'LOGNAME': 'cltbld', 21:38:40 INFO - 'MAIL': '/var/mail/cltbld', 21:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:40 INFO - 'MOZ_NO_REMOTE': '1', 21:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:40 INFO - 'NO_EM_RESTART': '1', 21:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:40 INFO - 'PWD': '/builds/slave/test', 21:38:40 INFO - 'SHELL': '/bin/bash', 21:38:40 INFO - 'SHLVL': '1', 21:38:40 INFO - 'TERM': 'linux', 21:38:40 INFO - 'TMOUT': '86400', 21:38:40 INFO - 'USER': 'cltbld', 21:38:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:40 INFO - '_': '/tools/buildbot/bin/python'} 21:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:40 INFO - Running setup.py (path:/tmp/pip-B3Csdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:40 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)) 21:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:40 INFO - Running setup.py (path:/tmp/pip-P76hWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:40 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)) 21:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:40 INFO - Running setup.py (path:/tmp/pip-ClBVyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:40 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)) 21:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:40 INFO - Running setup.py (path:/tmp/pip-Pztm1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:41 INFO - Running setup.py (path:/tmp/pip-aaqIud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:41 INFO - Running setup.py (path:/tmp/pip-YqlZ9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:41 INFO - Running setup.py (path:/tmp/pip-mAKylO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:41 INFO - Running setup.py (path:/tmp/pip-0GMDr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:41 INFO - Running setup.py (path:/tmp/pip-FGkFcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:41 INFO - Running setup.py (path:/tmp/pip-f6QzCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:41 INFO - Running setup.py (path:/tmp/pip-_rPld9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:41 INFO - Running setup.py (path:/tmp/pip-Oy5bm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:41 INFO - Running setup.py (path:/tmp/pip-1oQn5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:41 INFO - Running setup.py (path:/tmp/pip-qIFwc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:41 INFO - Running setup.py (path:/tmp/pip-NlgrJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:41 INFO - Running setup.py (path:/tmp/pip-1Zp591-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:41 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)) 21:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:41 INFO - Running setup.py (path:/tmp/pip-yxYCVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:41 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)) 21:38:41 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)) 21:38:41 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)) 21:38:41 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)) 21:38:41 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)) 21:38:41 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)) 21:38:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:43 INFO - Downloading blessings-1.6.tar.gz 21:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:38:43 INFO - Installing collected packages: blessings 21:38:43 INFO - Running setup.py install for blessings 21:38:44 INFO - Successfully installed blessings 21:38:44 INFO - Cleaning up... 21:38:44 INFO - Return code: 0 21:38:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:44 INFO - Reading from file tmpfile_stdout 21:38:44 INFO - Current package versions: 21:38:44 INFO - argparse == 1.2.1 21:38:44 INFO - blessings == 1.6 21:38:44 INFO - blobuploader == 1.2.4 21:38:44 INFO - docopt == 0.6.1 21:38:44 INFO - functools32 == 3.2.3-2 21:38:44 INFO - jsonschema == 2.5.1 21:38:44 INFO - manifestparser == 1.1 21:38:44 INFO - mozInstall == 1.12 21:38:44 INFO - mozcrash == 0.17 21:38:44 INFO - mozdebug == 0.1 21:38:44 INFO - mozdevice == 0.48 21:38:44 INFO - mozfile == 1.2 21:38:44 INFO - mozhttpd == 0.7 21:38:44 INFO - mozinfo == 0.9 21:38:44 INFO - mozleak == 0.1 21:38:44 INFO - mozlog == 3.4 21:38:44 INFO - moznetwork == 0.27 21:38:44 INFO - mozprocess == 0.23 21:38:44 INFO - mozprofile == 0.28 21:38:44 INFO - mozrunner == 6.12 21:38:44 INFO - mozscreenshot == 0.1 21:38:44 INFO - mozsystemmonitor == 0.3 21:38:44 INFO - moztest == 0.7 21:38:44 INFO - mozversion == 1.4 21:38:44 INFO - psutil == 3.1.1 21:38:44 INFO - requests == 1.2.3 21:38:44 INFO - wsgiref == 0.1.2 21:38:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:44 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')]} 21:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:44 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')]} 21:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:44 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 0x7fe729b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, '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': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', '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 21:38:44 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 21:38:44 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 21:38:44 INFO - Using env: {'DISPLAY': ':0', 21:38:44 INFO - 'HOME': '/home/cltbld', 21:38:44 INFO - 'LANG': 'en_US.UTF-8', 21:38:44 INFO - 'LANGUAGE': 'en_US:en', 21:38:44 INFO - 'LOGNAME': 'cltbld', 21:38:44 INFO - 'MAIL': '/var/mail/cltbld', 21:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:44 INFO - 'MOZ_NO_REMOTE': '1', 21:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:44 INFO - 'NO_EM_RESTART': '1', 21:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:44 INFO - 'PWD': '/builds/slave/test', 21:38:44 INFO - 'SHELL': '/bin/bash', 21:38:44 INFO - 'SHLVL': '1', 21:38:44 INFO - 'TERM': 'linux', 21:38:44 INFO - 'TMOUT': '86400', 21:38:44 INFO - 'USER': 'cltbld', 21:38:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:44 INFO - '_': '/tools/buildbot/bin/python'} 21:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:44 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)) 21:38:44 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)) 21:38:44 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)) 21:38:44 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)) 21:38:44 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)) 21:38:44 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)) 21:38:44 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)) 21:38:44 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)) 21:38:44 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)) 21:38:44 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)) 21:38:44 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)) 21:38:44 INFO - Cleaning up... 21:38:44 INFO - Return code: 0 21:38:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:38:44 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')]} 21:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:44 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')]} 21:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:44 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 0x7fe729b33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, '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': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', '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 21:38:44 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 21:38:44 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 21:38:44 INFO - Using env: {'DISPLAY': ':0', 21:38:44 INFO - 'HOME': '/home/cltbld', 21:38:44 INFO - 'LANG': 'en_US.UTF-8', 21:38:44 INFO - 'LANGUAGE': 'en_US:en', 21:38:44 INFO - 'LOGNAME': 'cltbld', 21:38:44 INFO - 'MAIL': '/var/mail/cltbld', 21:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:44 INFO - 'MOZ_NO_REMOTE': '1', 21:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:44 INFO - 'NO_EM_RESTART': '1', 21:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:44 INFO - 'PWD': '/builds/slave/test', 21:38:44 INFO - 'SHELL': '/bin/bash', 21:38:44 INFO - 'SHLVL': '1', 21:38:44 INFO - 'TERM': 'linux', 21:38:44 INFO - 'TMOUT': '86400', 21:38:44 INFO - 'USER': 'cltbld', 21:38:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:44 INFO - '_': '/tools/buildbot/bin/python'} 21:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:38:44 INFO - Cleaning up... 21:38:44 INFO - Return code: 0 21:38:44 INFO - Running post-action listener: _resource_record_post_action 21:38:44 INFO - Running post-action listener: _start_resource_monitoring 21:38:44 INFO - Starting resource monitoring. 21:38:44 INFO - [mozharness: 2016-10-05 04:38:44.827701Z] Finished create-virtualenv step (success) 21:38:44 INFO - [mozharness: 2016-10-05 04:38:44.828167Z] Running install step. 21:38:44 INFO - Running pre-action listener: _resource_record_pre_action 21:38:44 INFO - Running main action method: install 21:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:45 INFO - Reading from file tmpfile_stdout 21:38:45 INFO - Detecting whether we're running mozinstall >=1.0... 21:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:38:45 INFO - Reading from file tmpfile_stdout 21:38:45 INFO - Output received: 21:38:45 INFO - Usage: mozinstall [options] installer 21:38:45 INFO - Options: 21:38:45 INFO - -h, --help show this help message and exit 21:38:45 INFO - -d DEST, --destination=DEST 21:38:45 INFO - Directory to install application into. [default: 21:38:45 INFO - "/builds/slave/test"] 21:38:45 INFO - --app=APP Application being installed. [default: firefox] 21:38:45 INFO - mkdir: /builds/slave/test/build/application 21:38:45 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'] 21:38:45 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 21:39:02 INFO - Reading from file tmpfile_stdout 21:39:02 INFO - Output received: 21:39:02 INFO - /builds/slave/test/build/application/firefox/firefox 21:39:02 INFO - Running post-action listener: _resource_record_post_action 21:39:02 INFO - [mozharness: 2016-10-05 04:39:02.154102Z] Finished install step (success) 21:39:02 INFO - [mozharness: 2016-10-05 04:39:02.154348Z] Running run-tests step. 21:39:02 INFO - Running pre-action listener: _resource_record_pre_action 21:39:02 INFO - Running main action method: run_tests 21:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:39:02 INFO - Python 2.7.3 21:39:02 INFO - Return code: 0 21:39:02 INFO - grabbing minidump binary from tooltool 21:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:02 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 0x24be790>, '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 0x24bf690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:39:02 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 21:39:02 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 21:39:02 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 21:39:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:39:02 INFO - Return code: 0 21:39:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:39:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:39:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:39:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:39:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 21:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 21:39:02 INFO - Using env: {'DISPLAY': ':0', 21:39:02 INFO - 'HOME': '/home/cltbld', 21:39:02 INFO - 'LANG': 'en_US.UTF-8', 21:39:02 INFO - 'LANGUAGE': 'en_US:en', 21:39:02 INFO - 'LOGNAME': 'cltbld', 21:39:02 INFO - 'MAIL': '/var/mail/cltbld', 21:39:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:39:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:02 INFO - 'MOZ_NO_REMOTE': '1', 21:39:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:02 INFO - 'NO_EM_RESTART': '1', 21:39:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:02 INFO - 'PWD': '/builds/slave/test', 21:39:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:39:02 INFO - 'SHELL': '/bin/bash', 21:39:02 INFO - 'SHLVL': '1', 21:39:02 INFO - 'TERM': 'linux', 21:39:02 INFO - 'TMOUT': '86400', 21:39:02 INFO - 'USER': 'cltbld', 21:39:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841', 21:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:02 INFO - '_': '/tools/buildbot/bin/python'} 21:39:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 21:39:02 INFO - mozversion application_buildid: 20161004183012 21:39:02 INFO - mozversion application_changeset: ea104eeb14cc54da9a06c3766da63f73117723a0 21:39:02 INFO - mozversion application_display_name: Nightly 21:39:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:39:02 INFO - mozversion application_name: Firefox 21:39:02 INFO - mozversion application_remotingname: firefox 21:39:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:39:02 INFO - mozversion application_vendor: Mozilla 21:39:02 INFO - mozversion application_version: 52.0a1 21:39:02 INFO - mozversion platform_buildid: 20161004183012 21:39:02 INFO - mozversion platform_changeset: ea104eeb14cc54da9a06c3766da63f73117723a0 21:39:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:39:02 INFO - mozversion platform_version: 52.0a1 21:39:02 INFO - using testdate: 1475642342 21:39:02 INFO - actual date: 1475642342 21:39:02 INFO - starting webserver on 'localhost:42437' 21:39:02 INFO - SUITE-START | Running 2 tests 21:39:02 INFO - TEST-START | dromaeo_css 21:39:02 INFO - operating with platform_type : linux_ 21:39:02 INFO - Initialising browser for dromaeo_css test... 21:39:02 INFO - TEST-INFO | started process 5809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNqWD8s/profile http://localhost:42437/getInfo.html) 21:39:06 INFO - PROCESS | 5809 | __metrics Screen width/height:1600/1200 21:39:06 INFO - PROCESS | 5809 | colorDepth:24 21:39:06 INFO - PROCESS | 5809 | Browser inner width/height: 1024/697 21:39:06 INFO - PROCESS | 5809 | __metrics 21:39:07 INFO - PROCESS | 5809 | 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" 21:39:07 INFO - PROCESS | 5809 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:39:07 INFO - PROCESS | 5809 | console.error: PushService: 21:39:07 INFO - PROCESS | 5809 | stateChangeProcessEnqueue: Error transitioning state 21:39:07 INFO - PROCESS | 5809 | UnknownError 21:39:08 INFO - TEST-INFO | 5809: exit 0 21:39:08 INFO - Browser initialized. 21:39:08 INFO - Running cycle 1/1 for dromaeo_css test... 21:39:08 INFO - TEST-INFO | started process 5895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNqWD8s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:20 INFO - PROCESS | 5895 | RSS: Main: 173821952 21:39:20 INFO - PROCESS | 5895 | 21:40:12 INFO - PROCESS | 5895 | 1475642412513 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] 21:42:22 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42437/tests/dromaeo/cssquery-ext.html) 21:42:24 INFO - PROCESS | 5895 | RSS: Main: 316436480 21:42:24 INFO - PROCESS | 5895 | 21:45:26 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-ext.html (next: http://localhost:42437/tests/dromaeo/cssquery-jquery.html) 21:45:27 INFO - PROCESS | 5895 | RSS: Main: 273055744 21:45:27 INFO - PROCESS | 5895 | 21:48:29 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42437/tests/dromaeo/cssquery-mootools.html) 21:48:29 INFO - PROCESS | 5895 | RSS: Main: 215801856 21:48:29 INFO - PROCESS | 5895 | 21:51:31 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42437/tests/dromaeo/cssquery-prototype.html) 21:51:32 INFO - PROCESS | 5895 | RSS: Main: 250257408 21:51:32 INFO - PROCESS | 5895 | 21:54:35 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42437/tests/dromaeo/cssquery-yui.html) 21:54:35 INFO - PROCESS | 5895 | RSS: Main: 216002560 21:54:35 INFO - PROCESS | 5895 | 21:57:39 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:42437/tests/dromaeo/cssquery-yui.html (next: http://localhost:42437/tests/dromaeo/cssquery-dojo.html) 21:57:39 INFO - PROCESS | 5895 | RSS: Main: 304619520 21:57:39 INFO - PROCESS | 5895 | 21:57:39 INFO - PROCESS | 5895 | __start_tp_report 21:57:39 INFO - PROCESS | 5895 | _x_x_mozilla_page_load 21:57:39 INFO - PROCESS | 5895 | _x_x_mozilla_page_load_details 21:57:39 INFO - PROCESS | 5895 | |i|pagename|runs| 21:57:39 INFO - PROCESS | 5895 | |0;dojo.html;3026.6519350274716;3058.1437197584683;3075.3388021575365;3103.3327834515576;3108.922276943076;5191.714455704935;5261.105612045952;5270.841874743759;5338.306020217371;5393.865153371167;5238;5300.628955973074;5306.230596563496;5309.30978972733;5332.493413125757;4809.759512024402;4837;4875.00062487191;4875.561199492045;4898.902021959559;4860.684055536397;4889.33993910821;4913.26301054841;4914.11545921734;4972.328735620681;4661.277501987163;4882.926756098661;4892.902141957141;4944.258361245824;4981.1532039553185;4677.2750223715375;4753.382060332169;4811.230203167476;4828.686135401188;4867.075255701406;4774.188387974053;4779.784909679072;4789.521047895218;4790.520947905182;4846.030793841246;5247.239150323182;5280.498352656491;5289.264438296077;5295.391030031518;5300.628955973083;5366.812161574326;5409.134538473825;5566.415526369754;5634.154876768476;5641.576881733887;5679.630823996427;5693.402192769741;5695.117256825199;5696.458836410576;5757.963566558018;5292.8412147635245;5303.602229832778;5304.098303288489;5304.6286759926825;5359.14253719403;5481.588880833953;5525.502704756591;5726.885462290731;5784.971075144597;5812.38969908162;5562.443755624486;5566.443355664401;5571.164325351148;5626;5637.830865074055;5605.887882242332;5645.491905728504;5654.37801841797;5656.830295091154;5659.377468478464;5455.809046683347;5503.422140675251;5521.420250873681;5576.470235327637;5644.153376993484;5502.477264659851;5545.77816887328;5557.44425557441;5577.05190117681;5622.57830662702;4299.656027517791;4304.225239456865;4304.4834619845815;4308.870733877989;4359.193549193409;3748.0817199785683;3767.453719210699;3842.884713458601;3865.1496670732395;3920.0591857953887;5328.094223981932;5383.273258110184;5386.057439947994;5452.700101494456;5514.338279406497;5731.770729170787;5739;5741.1388291756575;5742.253507044057;5746.109353050284;5173.4826517347965;5383.43473935239;5435.895913429399;5445.2921120254905;5454.7272636368025;4757.690750101302;4826.903461930812;4892.951070489249;4894.730789806595;4984.675996060245;5922.141289512911;5932.940670593412;5934.910976335358;5938.465538101592;5939.168516407706;5647.519960803378;5704.3154821421695;5713.685747283939;5719.971400143139;5722.4277572242445;5667.631603945731;5735.11105778605;5736.340320862987;5879.265091863517;6014.609050411709;5570.470805273492;5603.019471592536;5654.519365853948;5668.7732490701555;5689.800856969986;5700.600957933071;5714.885702286014;5720.227769251098;5720.971395142998;5724.026915424472;5298.788048478172;5332.946670533245;5586.301712285965;5587.664740115443;5598.496135347838;5497.917531237114;5538.390777014606;5564.805231816867;5584.050711379156;5650.773969041193;5522.30971128609;5524.696141712245;5535.6955367455175;5539.8892022160135;5545.085060964896;5228.693026083675;5606.719664016864;5613.550915926798;5619.297587801525;5619.775208991595;5225.790968361223;5299.39057008449;5380.031594313061;5416.485433883775;5433.293671822637 21:57:39 INFO - PROCESS | 5895 | |1;ext.html;583.4224118123057;602.9547783916206;603.3815339277238;620.9505934969903;624.9093881387199;32158.67841321586;42629.360559591594;43644.56355436449;43648.78175609117;46556.76721616387;44850;45219.32171017437;45306.32040519395;45314.78879928809;45318.92129708325;8208.753737387888;8979.955100224506;9150.816983660323;9154.725358239264;9159.725208243763;8243.05204901438;10554.155667546616;10903.945480272587;10908.34549927007;11301.717457063556;11165.609203677874;11221.943890280538;11226.101911847074;11232.775344493106;11236.887631123665;8331.875021874677;8535.274501667365;10801.297915635458;10858.402787846744;10865.891341086566;10380.792384152275;10741.570337186504;10744.409057501834;11060.778784424267;11070.225084244106;42655;43016.784916075536;43050.13899721988;43059.13881722379;43092.78453607712;3527.435610302365;3584.5160903277983;3595.694365978895;3644.599094099647;3666.7616604920595;31316;31859.84070079658;31926.840365798256;32225;33434.66565334364;4249.68127390447;4409.162259170747;4412.580804823537;4448.266036104039;4635.351050852883;343550;343685;344532;344556;345205;34434;35452.64547354494;55947.16079258815;56306.43693563094;56404.717976409855;36870.63129368726;37172.62827371692;37208.813955930586;37351.25297494035;37471.43792843109;13900.93049534766;14003.339365520518;14009.159450433006;14010.85989140116;14021.29893505341;10527;10755.247132700635;11056.944715276533;11489.138314626269;11575.479103440366;8376.41365104449;8445.451045682012;8592.183742544448;8593.871091933626;8606.956965215259;3293.637699853014;3361.5125806758374;3389.1018879996823;3417.79493230407;3433.4163192257374;987.4865070163474;1071.5338827610015;1101.6419663609358;1129.2095533126844;1140.4582823159099;31886.84056579702;31966.360672786413;31989;32110.197245068593;32691.836540817145;1033.788073444942;1087.8694556653252;1095.5179720922768;1109.8723646780722;1135.0465608888574;15230.543083707507;16309.51071467858;16350.83649163517;16436.63926232073;16458.42395516151;507216;512507.87429131556;513340;514081;514134;55069.44930550643;55340.44659553433;55412.445875540725;55431.44568554343;56030.719846400505;1223.6573759347398;1281.3080936294482;1303.7457695749617;1341.7450684370133;1347.2253454263837;29015.564766528096;32380.514292286105;32684;32754;33058.66941330556;48600.75699621479;49170.262446062625;49173;49222.75388623034;49448.50551494439;411345;414974;415244;415478;416011;27375.315617108936;27442.725572744017;28570.714292857636;28607.856960715897;29465.852670737368;43246.78376608097;43720;43756.78121609372;43868.78065609652;44772.77613611911;37133.81433092817;37421.81289093537;38010.23979520449;38058.42912356372;39509.2098158041;37824.62175378211;37901.631546873694;37923;38523;39339.409908851965;37667.24665506729;38140;38412.42381364338;38875;39061.2187756249;32144;34299.65700343064;34608;34820.30359392849;34862.65137348594;26509.469810603296;26865;26889.327766805985;26897.462050759266;27079.1876243713 21:57:39 INFO - PROCESS | 5895 | |2;jquery.html;386.98645547405846;393.5159753503191;405.54173783624503;406.73562184580027;428.6742076022222;13260.403281852316;15312.617184570392;18561.257549698013;18909.43271701851;19149.04254787262;18902.338418155367;19257.807421925776;19341.4197574073;19415.32046378377;19455.124519396624;4860.125177468054;5498.972505137479;5724.398938111501;5728.79949201778;5734.655920644754;5482.424345443731;5573.6098473106895;5578.944210557904;5583.3300003999575;5583.6928968906695;5418.91871621926;5423.538999185074;5543.223948647193;5548.77804887804;5548.833534993957;5515.062439385314;5516.834494965137;5556.638818476807;5558.749856256478;5596.720163991784;5028.270900719375;5054.393472783289;5060.645754797166;5060.696358218482;5305.761240744176;13976.720465590632;14251.501197458143;14254.144751314954;14265.358058887376;21204.257850975297;2184.7924447177493;2214.3799736073925;2287.8055365293803;2583.7803786678155;2681.3564744461382;9903.108720215143;10109.34289271195;10136.847947280796;10651.573937042509;10774.676759697222;1804.3865085870736;1884.180381534037;1891.990540047291;1896.5637903282184;1920.6446807340546;79467;80461;83179;84891;85259.57370213109;10434.530446129942;10659.147268218523;10668.679939601825;11254.887451125383;11881.465334059989;15895.364185432685;15915.522534323989;15964.600884977968;15965.600859978593;15978.840211597735;7261.2572982483825;7423.1092268927;7458.291462311072;7563.697452101855;7580.772576822704;6981.162260528769;7016.894746578805;7017.543859649209;7071.964640176766;7235.095613048369;4706.599939005155;4765.76171191446;4826.203676393356;4860.975695121501;4899.755012249373;1918.5299601597699;1986.3147214211074;1997.8423302832905;2032.89835508224;2055.270379015458;830.5722552885269;961.2262128986233;995.2734503812258;1042.760165162017;1045.6444808764904;17703;19537.609247814966;19540.413787586396;20775.68836467454;20927.688436713815;931.3387494878576;942.0391200974967;947.4457442396138;976.8485884687884;1050.2805578178973;10306.690799276033;10640.680779576625;10791.352518848895;10845.295055821347;10913.126949843994;341784;341819;342784;438168;440943;88334;92040.53979730059;92329.5383523078;92495.53752231196;94099;997.5112195024386;998.5955687946393;1037.9325343852624;1044.3733759744093;1051.4690081508788;16562.917185413997;17032.318707251572;17321.91339043347;17375.391861284796;17414.129293535527;39613;39716.80141599273;39764.42709088492;40526.39210411787;41525.58474415338;50939;51396;56756;57210.281331713304;58125.12812307734;7928.643211055401;8428.704995325133;8466.492010479391;8565.186307300797;8790;12316;12342.444589993293;12837.42231599599;12974.416151273404;13607.931960340135;5651.321841378896;7879.724209652634;9378.531073446436;10733.195010374096;11432.314061156358;10648.148148148284;10687.412192329497;10799.568017279535;10880.510377033212;10889.618863339745;11228.157888158585;11250.493727782106;11326.490307936327;11378.772424551627;12092.697682558006;8370.204830541088;8382.538960356995;8444.915550844413;8546.273566746897;8725.650973961225;9858.901410985798;11314.264572802742;11632.360220187971;11636.069114470652;11834.46744896499 21:57:39 INFO - PROCESS | 5895 | |3;mootools.html;1350.2573584528507;1472.0946617830039;1496.9625759356015;1644.4408900973667;1768.7523746675467;7741.8838717419285;8759.824803503927;9088.591013404397;9099.90900090999;9374.343795934288;9108.544572771352;9202.401843880143;9207.585658645361;9209;9212.861807072883;2386.653935179402;2421.7699318564796;2421.83047186697;2424.4302588891596;2427.635854621803;2338.1348900906687;2374.8456350337174;2403.267003563912;2406.3863714752715;2407.3861165402886;2379.1553998330605;2397.9640305395433;2404.206611818096;2413.8431001984814;2420.576399130154;2286.9199578014855;2289.599320118981;2292.0946226240626;2293.20884294918;2339.2748248043163;2227.0646328542052;2231.866088034723;2234.843560950734;2235.698180745595;2242.439390152462;8890.244329232022;8976.371653984224;8993.190612844875;9016.098390160996;9067.501287429188;5295.920561191547;5442.809501667422;5511.118221084607;5511.448855114497;5513.972430137864;3719.75821571597;3723.3484140275614;3730.1234209960908;3786.962130378716;3805.7145714071557;1206.3546002888413;1209.2260952990093;1218.585680868509;1244.4959791284543;1258.9559365422258;12706.04704647155;12718.554850580185;12795.488180472863;12868.420921058574;12877.034222433262;4535.63714902807;4700.2009658358165;4817.78319975602;4825.372701548777;4878.9512104878495;9891.653792117242;9895.158911492459;9898.80202395948;9901.158401535806;9905.900940990497;5532.917006244909;5552.833414997475;5558.861028474321;5558.916616250759;5559.138333558305;4498.077894031781;4656.5110663379855;4949.925751113737;5089;5172.9741351293005;3893.104585945192;4018.1561872007205;4054.3107671695884;4059.7767122808527;4083.305838007546;1245.5080243303844;1249.3503378243263;1254.1346470935025;1261.6782720406238;1267.87955144263;926.972190834276;978.2760757039739;982.1946004276425;995.7659949911765;1004.6885465505717;6075.840562907263;6103.542234332443;6143.6928153593035;6191.25704915413;6216.316205217422;477.5773440505109;478.1298037571656;488.63840757838943;501.9171836646912;503.26272011503323;4140.855070072533;4249.79789007219;4323.935140972888;4365.9126817463475;4444.288913773846;11118.555257789598;11442.427878606037;11469.71325716847;11486;11496;11285.830712539318;11286.266392684449;11302.604408845651;11345;11345.432728363548;8062.516249025077;8284.50292982423;8365.623546940402;8415.873761893576;8446.408751387467;6025.909611355921;6365.04524321337;6395.936040639534;6417.518686098655;6481;9886.85169722469;10630;10638.202134840072;10670.679879603624;10676.679699609023;10495.895041049796;10625.468726563795;10672.986066323687;10784.946075269574;10799.892001079888;6973.372396484341;7094.116132354688;7541.095068591804;7990.320822730133;8150.510969341622;8726.3891527595;8831.91168088311;8841.16008979146;8871.733847984571;8913.598888049924;7608.923910761043;7630.618469076413;7770.611469426619;7865.292123708894;8182.386321025828;7482.775516734507;7585.886211706718;7597.2022937590755;7652.655630496753;7692.730754423568;7084.681189346595;7194.748183813542;7198.8920166198595;7199.532030418006;7215.314545118205;5201.6098792591465;5240.659357141773;5281.894362112813;5285.973570132125;5523.696196709059;5362.222477740784;5382.138857782736;5452.91820622683;5484.533814625802;5595.972020139873 21:57:39 INFO - PROCESS | 5895 | |4;prototype.html;332.02683719879377;336.2468071519796;346.84912063252494;347.80001499137984;351.2080259015919;5193.45468725784;5242.475752424755;5325.573954083674;5344.866378340544;5391.838244852655;5136.255242989773;5220.4779522047775;5238.585581892887;5272.393674727407;5276.3668359796875;4176.2900306947895;4186.39297301891;4194.433751443562;4196.328587426013;4200.285951388271;3984.86052988144;4121.793910304487;4188.246115699173;4192.685548583853;4202.789860506978;4094.7133700640966;4099.836006559749;4103.774292413916;4107.404426358176;4116.855910043149;4100.2414553307735;4111.527174374955;4113;4130.256553820311;4133.565975572552;3622.040159357772;3626.165981824195;3640.7451478396524;3657.9817100914324;3662.853485860562;5096.694198348111;5119.257707632372;5140.948590514085;5147;5169.707573106723;4693.671442998992;4699.107169637758;4702.4716966985525;4704.95295047052;4711.717296962193;5427.592930530186;5438.265834112383;5454.563634909197;5454.809081682161;5455.890882182373;3756;3944.9013774655577;3959.4060890866313;3960.3069462844173;3964.7224694271413;5698.373178950312;5734.655920644733;5736.42635736423;5737.483626473638;5744.253247077853;4060.2285565742413;4093.5906409358827;4107.466029416157;4121.9587804121575;4129.566395528486;3942.5071866016747;4100.569440208735;4125.525564560054;4147.294959856831;4185.455890734246;4678.6491013174145;4693;4703.670743047954;4707.7175369477945;4721.716696998191;5494.1758736189895;5524.116141417354;5529.82035329687;5564.4991950724625;5611.971940140274;1330.8003799430162;1351.3243378310844;1357.5520078374311;1398;1401.537492627451;899.6941040046415;905.343625871238;916.2532535983153;927.5037854747677;941.5104145844123;4673.551199128281;4678.95321046792;4680.789364478538;4698.530146985342;4735.3537775912355;4851.563359297609;4863.489333619919;4903.975480122576;4916.729579873141;4930.09124616478;4672.345871577982;4683.976580117078;4688.5619477872;4691;4714.481407045222;2780.694123646397;2936.6329208848892;2967.9908830997565;2970.212893583202;2989.880404783828;5851.619644723164;5852.946469635506;5872.530197584183;5873.647581145145;5915.704214789243;5525.640833345819;5729.369769325371;5748.390450673818;5791.420857914259;5841.795537156179;5839.299284085937;5879.206307148565;5882.705864706748;5891.293044834647;5903.4686878179455;5639.3232812062815;5643.633163844337;5654.85862853432;5698.287714035746;5719.513841323368;5357.258890860564;5550.389457159628;5568.49883510486;5573.359063707726;5576.553875690016;5861.501772349398;5866.67733274674;5876.676782776988;5878.441548052928;5919.644821310735;4021.819018144132;4062.1469491407133;4075.65356944663;4078.9796051020744;4079.2255368914616;5368.40947495783;5602.915956260578;5633.267675202197;5652.152177173457;5659.773609055756;5332.493413125747;5400.324959380077;5461.972690136524;5510.173473978935;5519.172124181405;5477.452254774491;5481.643693159932;5521.309836270466;5529.253550770594;5532.391436941853;5264.0259902536545;5408.864778380572;5447.945520544744;5469.863253418696;5487.945120548743;5488.670679759227;5494.681276493693;5495.884084627367;5525.585581081516;5525.972370138124;5425.755840987244;5428.511433970962;5438.809641662523;5451.836444906659;5467.863303417446 21:57:39 INFO - PROCESS | 5895 | |5;yui.html;717.601731039273;744.6611791634807;766.1916677904811;793.3217099380029;821.6056292979368;14800.259987000647;15817.050976941391;15825.129617871013;15853.445129420472;15966;13687.726245475085;14682.265886705649;14824.6293842654;14831.406743730238;14854.33155508002;784.9293563579276;805.8267472493412;806.8547661420971;808.2564041082219;808.8827120067587;662.2053535757086;681.5603935461625;783.8510682970245;811.8701007838747;816.5631387207845;837.8563261148519;845.8984921809391;850.4514588090677;850.6469815026757;851.8764779107025;839.8698201778673;840.5923127283263;841.3017195727532;841.7727213652311;843.7890527368158;502.5200933108872;519.1045446604614;520.9088409528317;620.512897375558;621.0808004153878;12530.874691253153;13594.728105437836;14107.717845643132;14122.152670839783;14606.342714577764;14665.56003319902;15047.247637618184;15505.379784808707;15525;15956.281967311383;12213.104180517419;12255.448504817305;12292.262464252173;12465.563705270362;13026.739465210738;3897.162110146304;3912.7456715313415;4055.655269302113;4115.54728979812;4116.073883376246;82506.58746706288;82773.17226827654;83829.58085209534;83858.58070709607;83928.58035709782;11125.554977800959;11239.381833999209;11243.269187502787;11315.490802913888;11442.313461192354;23309;23402.64896026561;23442.882785585964;23459.648105278433;23949.16177933799;8457.323414126855;8597.871031934526;8600.5699715014;8741.868871966799;8786.297096232285;4602.953970460319;4799.328094066834;4809.134355815987;4872.342233798463;4906.411230652345;3738.32710112177;3815.923681526354;3869.806509674505;3879.243547508209;3881.476000739864;612.6109920200705;627.209715758148;632.5761739634456;640.4684112186874;645.854682696399;641.8780431717959;650.677914432359;680.0071895033208;712.9928700713031;741.588418427767;9096.317776166814;9749.268804839665;9900.158486528582;10101.69694909154;10181.287309888385;723.2622724820653;734.1667207719171;744.7132853851198;751.305042835375;755.0637209859734;4631.698939568917;5032.521910418504;5036.471170527115;5046.243063540498;5090.421303656627;103055.96944030463;118759;120243;122037;122324.38837805932;99229;103156.48421757843;103992.48003760084;108522;109073;88533;88756.11243887608;89359.55320223357;90325.54837225772;91276.0468743755;9343.813123737624;9583.568739406604;9605.135537801352;9641.42151470914;9676.70969870905;53763.73118134384;54583;54692.72653636707;56131.15803263036;56507.71746141243;74282;75976.62011689907;76772.23227767875;78763.60618196872;83273;12925.438224448848;13063.412146453622;13073.496547897113;13178.934105329796;13399.866001339862;14628.488002919847;15145.848541514444;15147.396822224267;15599;16134.273957671698;13888.418852336716;14297.481466689796;14830.629234268798;15130.243487825785;15308.928375013642;14284.642883927985;14353.138811670915;14587.635309116933;14845.33196006204;15420.614484637974;13612.902586659487;14115.153090814583;14560.271986400849;14572.125672459686;15020.399184032516;11319.490622921823;11445.370504622326;11454.427278635869;11642.76714465723;11715.882841171479;11782.764344713229;11943.701407464883;11945.283283003047;12028.518859245532;12250.203736757083 21:57:39 INFO - PROCESS | 5895 | __end_tp_report 21:57:39 INFO - PROCESS | 5895 | __start_cc_report 21:57:39 INFO - PROCESS | 5895 | _x_x_mozilla_cycle_collect,1311 21:57:39 INFO - PROCESS | 5895 | __end_cc_report 21:57:39 INFO - PROCESS | 5895 | __startTimestamp1475643459345__endTimestamp 21:57:39 INFO - PROCESS | 5895 | 21:57:39 INFO - PROCESS | 5895 | ------- Summary: start ------- 21:57:39 INFO - PROCESS | 5895 | Number of tests: 6 21:57:39 INFO - PROCESS | 5895 | 21:57:39 INFO - PROCESS | 5895 | [#0] dojo.html Cycles:165 Average:5258.45 Median:5452.70 stddev:595.63 (10.9%) stddev-sans-first:571.15 21:57:39 INFO - PROCESS | 5895 | Values: 3026.7 3058.1 3075.3 3103.3 3108.9 5191.7 5261.1 5270.8 5338.3 5393.9 5238.0 5300.6 5306.2 5309.3 5332.5 4809.8 4837.0 4875.0 4875.6 4898.9 4860.7 4889.3 4913.3 4914.1 4972.3 4661.3 4882.9 4892.9 4944.3 4981.2 4677.3 4753.4 4811.2 4828.7 4867.1 4774.2 4779.8 4789.5 4790.5 4846.0 5247.2 5280.5 5289.3 5295.4 5300.6 5366.8 5409.1 5566.4 5634.2 5641.6 5679.6 5693.4 5695.1 5696.5 5758.0 5292.8 5303.6 5304.1 5304.6 5359.1 5481.6 5525.5 5726.9 5785.0 5812.4 5562.4 5566.4 5571.2 5626.0 5637.8 5605.9 5645.5 5654.4 5656.8 5659.4 5455.8 5503.4 5521.4 5576.5 5644.2 5502.5 5545.8 5557.4 5577.1 5622.6 4299.7 4304.2 4304.5 4308.9 4359.2 3748.1 3767.5 3842.9 3865.1 3920.1 5328.1 5383.3 5386.1 5452.7 5514.3 5731.8 5739.0 5741.1 5742.3 5746.1 5173.5 5383.4 5435.9 5445.3 5454.7 4757.7 4826.9 4893.0 4894.7 4984.7 5922.1 5932.9 5934.9 5938.5 5939.2 5647.5 5704.3 5713.7 5720.0 5722.4 5667.6 5735.1 5736.3 5879.3 6014.6 5570.5 5603.0 5654.5 5668.8 5689.8 5700.6 5714.9 5720.2 5721.0 5724.0 5298.8 5332.9 5586.3 5587.7 5598.5 5497.9 5538.4 5564.8 5584.1 5650.8 5522.3 5524.7 5535.7 5539.9 5545.1 5228.7 5606.7 5613.6 5619.3 5619.8 5225.8 5299.4 5380.0 5416.5 5433.3 21:57:39 INFO - PROCESS | 5895 | 21:57:39 INFO - PROCESS | 5895 | [#1] ext.html Cycles:180 Average:56978.26 Median:3590.11 stddev:113874.38 (3171.9%) stddev-sans-first:114115.11 21:57:39 INFO - PROCESS | 5895 | Values: 583.4 603.0 603.4 621.0 624.9 32158.7 42629.4 43644.6 43648.8 46556.8 44850.0 45219.3 45306.3 45314.8 45318.9 8208.8 8980.0 9150.8 9154.7 9159.7 8243.1 10554.2 10903.9 10908.3 11301.7 11165.6 11221.9 11226.1 11232.8 11236.9 8331.9 8535.3 10801.3 10858.4 10865.9 10380.8 10741.6 10744.4 11060.8 11070.2 42655.0 43016.8 43050.1 43059.1 43092.8 3527.4 3584.5 3595.7 3644.6 3666.8 31316.0 31859.8 31926.8 32225.0 33434.7 4249.7 4409.2 4412.6 4448.3 4635.4 343550.0 343685.0 344532.0 344556.0 345205.0 34434.0 35452.6 55947.2 56306.4 56404.7 36870.6 37172.6 37208.8 37351.3 37471.4 13900.9 14003.3 14009.2 14010.9 14021.3 10527.0 10755.2 11056.9 11489.1 11575.5 8376.4 8445.5 8592.2 8593.9 8607.0 3293.6 3361.5 3389.1 3417.8 3433.4 987.5 1071.5 1101.6 1129.2 1140.5 31886.8 31966.4 31989.0 32110.2 32691.8 1033.8 1087.9 1095.5 1109.9 1135.0 15230.5 16309.5 16350.8 16436.6 16458.4 507216.0 512507.9 513340.0 514081.0 514134.0 55069.4 55340.4 55412.4 55431.4 56030.7 1223.7 1281.3 1303.7 1341.7 1347.2 29015.6 32380.5 32684.0 32754.0 33058.7 48600.8 49170.3 49173.0 49222.8 49448.5 411345.0 414974.0 415244.0 415478.0 416011.0 27375.3 27442.7 28570.7 28607.9 29465.9 43246.8 43720.0 43756.8 43868.8 44772.8 37133.8 37421.8 38010.2 38058.4 39509.2 37824.6 37901.6 37923.0 38523.0 39339.4 37667.2 38140.0 38412.4 38875.0 39061.2 32144.0 34299.7 34608.0 34820.3 34862.7 26509.5 26865.0 26889.3 26897.5 27079.2 21:57:39 INFO - PROCESS | 5895 | 21:57:39 INFO - PROCESS | 5895 | [#2] jquery.html Cycles:180 Average:25440.31 Median:20003.26 stddev:64165.23 (320.8%) stddev-sans-first:64317.66 21:57:39 INFO - PROCESS | 5895 | Values: 387.0 393.5 405.5 406.7 428.7 13260.4 15312.6 18561.3 18909.4 19149.0 18902.3 19257.8 19341.4 19415.3 19455.1 4860.1 5499.0 5724.4 5728.8 5734.7 5482.4 5573.6 5578.9 5583.3 5583.7 5418.9 5423.5 5543.2 5548.8 5548.8 5515.1 5516.8 5556.6 5558.7 5596.7 5028.3 5054.4 5060.6 5060.7 5305.8 13976.7 14251.5 14254.1 14265.4 21204.3 2184.8 2214.4 2287.8 2583.8 2681.4 9903.1 10109.3 10136.8 10651.6 10774.7 1804.4 1884.2 1892.0 1896.6 1920.6 79467.0 80461.0 83179.0 84891.0 85259.6 10434.5 10659.1 10668.7 11254.9 11881.5 15895.4 15915.5 15964.6 15965.6 15978.8 7261.3 7423.1 7458.3 7563.7 7580.8 6981.2 7016.9 7017.5 7072.0 7235.1 4706.6 4765.8 4826.2 4861.0 4899.8 1918.5 1986.3 1997.8 2032.9 2055.3 830.6 961.2 995.3 1042.8 1045.6 17703.0 19537.6 19540.4 20775.7 20927.7 931.3 942.0 947.4 976.8 1050.3 10306.7 10640.7 10791.4 10845.3 10913.1 341784.0 341819.0 342784.0 438168.0 440943.0 88334.0 92040.5 92329.5 92495.5 94099.0 997.5 998.6 1037.9 1044.4 1051.5 16562.9 17032.3 17321.9 17375.4 17414.1 39613.0 39716.8 39764.4 40526.4 41525.6 50939.0 51396.0 56756.0 57210.3 58125.1 7928.6 8428.7 8466.5 8565.2 8790.0 12316.0 12342.4 12837.4 12974.4 13607.9 5651.3 7879.7 9378.5 10733.2 11432.3 10648.1 10687.4 10799.6 10880.5 10889.6 11228.2 11250.5 11326.5 11378.8 12092.7 8370.2 8382.5 8444.9 8546.3 8725.7 9858.9 11314.3 11632.4 11636.1 11834.5 21:57:39 INFO - PROCESS | 5895 | 21:57:39 INFO - PROCESS | 5895 | [#3] mootools.html Cycles:180 Average:5946.19 Median:2725.92 stddev:3405.74 (124.9%) stddev-sans-first:3397.78 21:57:39 INFO - PROCESS | 5895 | Values: 1350.3 1472.1 1497.0 1644.4 1768.8 7741.9 8759.8 9088.6 9099.9 9374.3 9108.5 9202.4 9207.6 9209.0 9212.9 2386.7 2421.8 2421.8 2424.4 2427.6 2338.1 2374.8 2403.3 2406.4 2407.4 2379.2 2398.0 2404.2 2413.8 2420.6 2286.9 2289.6 2292.1 2293.2 2339.3 2227.1 2231.9 2234.8 2235.7 2242.4 8890.2 8976.4 8993.2 9016.1 9067.5 5295.9 5442.8 5511.1 5511.4 5514.0 3719.8 3723.3 3730.1 3787.0 3805.7 1206.4 1209.2 1218.6 1244.5 1259.0 12706.0 12718.6 12795.5 12868.4 12877.0 4535.6 4700.2 4817.8 4825.4 4879.0 9891.7 9895.2 9898.8 9901.2 9905.9 5532.9 5552.8 5558.9 5558.9 5559.1 4498.1 4656.5 4949.9 5089.0 5173.0 3893.1 4018.2 4054.3 4059.8 4083.3 1245.5 1249.4 1254.1 1261.7 1267.9 927.0 978.3 982.2 995.8 1004.7 6075.8 6103.5 6143.7 6191.3 6216.3 477.6 478.1 488.6 501.9 503.3 4140.9 4249.8 4323.9 4365.9 4444.3 11118.6 11442.4 11469.7 11486.0 11496.0 11285.8 11286.3 11302.6 11345.0 11345.4 8062.5 8284.5 8365.6 8415.9 8446.4 6025.9 6365.0 6395.9 6417.5 6481.0 9886.9 10630.0 10638.2 10670.7 10676.7 10495.9 10625.5 10673.0 10784.9 10799.9 6973.4 7094.1 7541.1 7990.3 8150.5 8726.4 8831.9 8841.2 8871.7 8913.6 7608.9 7630.6 7770.6 7865.3 8182.4 7482.8 7585.9 7597.2 7652.7 7692.7 7084.7 7194.7 7198.9 7199.5 7215.3 5201.6 5240.7 5281.9 5286.0 5523.7 5362.2 5382.1 5452.9 5484.5 5596.0 21:57:39 INFO - PROCESS | 5895 | 21:57:39 INFO - PROCESS | 5895 | [#4] prototype.html Cycles:180 Average:4596.02 Median:5181.58 stddev:1348.37 (26.0%) stddev-sans-first:1313.62 21:57:39 INFO - PROCESS | 5895 | Values: 332.0 336.2 346.8 347.8 351.2 5193.5 5242.5 5325.6 5344.9 5391.8 5136.3 5220.5 5238.6 5272.4 5276.4 4176.3 4186.4 4194.4 4196.3 4200.3 3984.9 4121.8 4188.2 4192.7 4202.8 4094.7 4099.8 4103.8 4107.4 4116.9 4100.2 4111.5 4113.0 4130.3 4133.6 3622.0 3626.2 3640.7 3658.0 3662.9 5096.7 5119.3 5140.9 5147.0 5169.7 4693.7 4699.1 4702.5 4705.0 4711.7 5427.6 5438.3 5454.6 5454.8 5455.9 3756.0 3944.9 3959.4 3960.3 3964.7 5698.4 5734.7 5736.4 5737.5 5744.3 4060.2 4093.6 4107.5 4122.0 4129.6 3942.5 4100.6 4125.5 4147.3 4185.5 4678.6 4693.0 4703.7 4707.7 4721.7 5494.2 5524.1 5529.8 5564.5 5612.0 1330.8 1351.3 1357.6 1398.0 1401.5 899.7 905.3 916.3 927.5 941.5 4673.6 4679.0 4680.8 4698.5 4735.4 4851.6 4863.5 4904.0 4916.7 4930.1 4672.3 4684.0 4688.6 4691.0 4714.5 2780.7 2936.6 2968.0 2970.2 2989.9 5851.6 5852.9 5872.5 5873.6 5915.7 5525.6 5729.4 5748.4 5791.4 5841.8 5839.3 5879.2 5882.7 5891.3 5903.5 5639.3 5643.6 5654.9 5698.3 5719.5 5357.3 5550.4 5568.5 5573.4 5576.6 5861.5 5866.7 5876.7 5878.4 5919.6 4021.8 4062.1 4075.7 4079.0 4079.2 5368.4 5602.9 5633.3 5652.2 5659.8 5332.5 5400.3 5462.0 5510.2 5519.2 5477.5 5481.6 5521.3 5529.3 5532.4 5264.0 5408.9 5447.9 5469.9 5487.9 5488.7 5494.7 5495.9 5525.6 5526.0 5425.8 5428.5 5438.8 5451.8 5467.9 21:57:39 INFO - PROCESS | 5895 | 21:57:39 INFO - PROCESS | 5895 | [#5] yui.html Cycles:180 Average:21740.18 Median:4359.51 stddev:31389.08 (720.0%) stddev-sans-first:31437.44 21:57:39 INFO - PROCESS | 5895 | Values: 717.6 744.7 766.2 793.3 821.6 14800.3 15817.1 15825.1 15853.4 15966.0 13687.7 14682.3 14824.6 14831.4 14854.3 784.9 805.8 806.9 808.3 808.9 662.2 681.6 783.9 811.9 816.6 837.9 845.9 850.5 850.6 851.9 839.9 840.6 841.3 841.8 843.8 502.5 519.1 520.9 620.5 621.1 12530.9 13594.7 14107.7 14122.2 14606.3 14665.6 15047.2 15505.4 15525.0 15956.3 12213.1 12255.4 12292.3 12465.6 13026.7 3897.2 3912.7 4055.7 4115.5 4116.1 82506.6 82773.2 83829.6 83858.6 83928.6 11125.6 11239.4 11243.3 11315.5 11442.3 23309.0 23402.6 23442.9 23459.6 23949.2 8457.3 8597.9 8600.6 8741.9 8786.3 4603.0 4799.3 4809.1 4872.3 4906.4 3738.3 3815.9 3869.8 3879.2 3881.5 612.6 627.2 632.6 640.5 645.9 641.9 650.7 680.0 713.0 741.6 9096.3 9749.3 9900.2 10101.7 10181.3 723.3 734.2 744.7 751.3 755.1 4631.7 5032.5 5036.5 5046.2 5090.4 103056.0 118759.0 120243.0 122037.0 122324.4 99229.0 103156.5 103992.5 108522.0 109073.0 88533.0 88756.1 89359.6 90325.5 91276.0 9343.8 9583.6 9605.1 9641.4 9676.7 53763.7 54583.0 54692.7 56131.2 56507.7 74282.0 75976.6 76772.2 78763.6 83273.0 12925.4 13063.4 13073.5 13178.9 13399.9 14628.5 15145.8 15147.4 15599.0 16134.3 13888.4 14297.5 14830.6 15130.2 15308.9 14284.6 14353.1 14587.6 14845.3 15420.6 13612.9 14115.2 14560.3 14572.1 15020.4 11319.5 11445.4 11454.4 11642.8 11715.9 11782.8 11943.7 11945.3 12028.5 12250.2 21:57:39 INFO - PROCESS | 5895 | -------- Summary: end -------- 21:57:39 INFO - PROCESS | 5895 | 21:57:40 INFO - TEST-INFO | 5895: exit 0 21:57:40 INFO - TEST-OK | dromaeo_css | took 1117870ms 21:57:40 INFO - TEST-START | kraken 21:57:40 INFO - operating with platform_type : linux_ 21:57:40 INFO - Initialising browser for kraken test... 21:57:40 INFO - TEST-INFO | started process 6199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoxFdPp/profile http://localhost:42437/getInfo.html) 21:57:44 INFO - PROCESS | 6199 | __metrics Screen width/height:1600/1200 21:57:44 INFO - PROCESS | 6199 | colorDepth:24 21:57:44 INFO - PROCESS | 6199 | Browser inner width/height: 1024/697 21:57:44 INFO - PROCESS | 6199 | __metrics 21:57:45 INFO - PROCESS | 6199 | 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" 21:57:45 INFO - PROCESS | 6199 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:57:45 INFO - PROCESS | 6199 | console.error: PushService: 21:57:45 INFO - PROCESS | 6199 | stateChangeProcessEnqueue: Error transitioning state 21:57:45 INFO - PROCESS | 6199 | UnknownError 21:57:46 INFO - TEST-INFO | 6199: exit 0 21:57:46 INFO - Browser initialized. 21:57:46 INFO - Running cycle 1/1 for kraken test... 21:57:46 INFO - TEST-INFO | started process 6280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoxFdPp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:58 INFO - PROCESS | 6280 | RSS: Main: 173678592 21:57:58 INFO - PROCESS | 6280 | 21:58:01 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42437/tests/kraken/driver.html?testName=audio-beat-detection) 21:58:01 INFO - PROCESS | 6280 | RSS: Main: 240775168 21:58:01 INFO - PROCESS | 6280 | 21:58:04 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42437/tests/kraken/driver.html?testName=audio-dft) 21:58:05 INFO - PROCESS | 6280 | RSS: Main: 218206208 21:58:05 INFO - PROCESS | 6280 | 21:58:08 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42437/tests/kraken/driver.html?testName=audio-fft) 21:58:08 INFO - PROCESS | 6280 | RSS: Main: 299307008 21:58:08 INFO - PROCESS | 6280 | 21:58:11 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42437/tests/kraken/driver.html?testName=audio-oscillator) 21:58:11 INFO - PROCESS | 6280 | RSS: Main: 210370560 21:58:11 INFO - PROCESS | 6280 | 21:58:13 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:58:14 INFO - PROCESS | 6280 | RSS: Main: 213782528 21:58:14 INFO - PROCESS | 6280 | 21:58:17 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42437/tests/kraken/driver.html?testName=imaging-darkroom) 21:58:17 INFO - PROCESS | 6280 | RSS: Main: 249909248 21:58:17 INFO - PROCESS | 6280 | 21:58:21 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42437/tests/kraken/driver.html?testName=imaging-desaturate) 21:58:21 INFO - PROCESS | 6280 | RSS: Main: 248426496 21:58:21 INFO - PROCESS | 6280 | 21:58:24 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42437/tests/kraken/driver.html?testName=json-parse-financial) 21:58:25 INFO - PROCESS | 6280 | RSS: Main: 248492032 21:58:25 INFO - PROCESS | 6280 | 21:58:26 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:27 INFO - PROCESS | 6280 | RSS: Main: 210808832 21:58:27 INFO - PROCESS | 6280 | 21:58:29 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:58:29 INFO - PROCESS | 6280 | RSS: Main: 217997312 21:58:29 INFO - PROCESS | 6280 | 21:58:31 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:58:32 INFO - PROCESS | 6280 | RSS: Main: 227446784 21:58:32 INFO - PROCESS | 6280 | 21:58:35 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:58:35 INFO - PROCESS | 6280 | RSS: Main: 232255488 21:58:35 INFO - PROCESS | 6280 | 21:58:38 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:58:39 INFO - PROCESS | 6280 | RSS: Main: 233078784 21:58:39 INFO - PROCESS | 6280 | 21:58:40 INFO - PROCESS | 6280 | Cycle 1(1): loaded http://localhost:42437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42437/tests/kraken/driver.html?testName=ai-astar) 21:58:41 INFO - PROCESS | 6280 | RSS: Main: 284733440 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | __start_tp_report 21:58:41 INFO - PROCESS | 6280 | _x_x_mozilla_page_load 21:58:41 INFO - PROCESS | 6280 | _x_x_mozilla_page_load_details 21:58:41 INFO - PROCESS | 6280 | |i|pagename|runs| 21:58:41 INFO - PROCESS | 6280 | |0;ai-astar;109;111;111;110;110;111;109;111;109;111 21:58:41 INFO - PROCESS | 6280 | |1;audio-beat-detection;150;124;123;173;122;127;129;124;162;122 21:58:41 INFO - PROCESS | 6280 | |2;audio-dft;160;161;160;160;161;161;161;162;163;170 21:58:41 INFO - PROCESS | 6280 | |3;audio-fft;75;76;75;108;76;75;76;75;117;76 21:58:41 INFO - PROCESS | 6280 | |4;audio-oscillator;82;82;119;82;83;82;103;82;82;114 21:58:41 INFO - PROCESS | 6280 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;118;118;117 21:58:41 INFO - PROCESS | 6280 | |6;imaging-darkroom;147;147;146;147;146;146;146;146;146;146 21:58:41 INFO - PROCESS | 6280 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;96 21:58:41 INFO - PROCESS | 6280 | |8;json-parse-financial;53;52;51;51;52;53;52;52;61;52 21:58:41 INFO - PROCESS | 6280 | |9;json-stringify-tinderbox;61;61;61;60;63;63;64;61;62;61 21:58:41 INFO - PROCESS | 6280 | |10;stanford-crypto-aes;81;80;79;80;80;80;79;78;81;79 21:58:41 INFO - PROCESS | 6280 | |11;stanford-crypto-ccm;135;135;142;140;146;132;130;139;191;141 21:58:41 INFO - PROCESS | 6280 | |12;stanford-crypto-pbkdf2;170;166;172;165;168;167;169;169;169;166 21:58:41 INFO - PROCESS | 6280 | |13;stanford-crypto-sha256-iterative;66;67;67;66;66;65;68;70;66;66 21:58:41 INFO - PROCESS | 6280 | __end_tp_report 21:58:41 INFO - PROCESS | 6280 | __start_cc_report 21:58:41 INFO - PROCESS | 6280 | _x_x_mozilla_cycle_collect,1644 21:58:41 INFO - PROCESS | 6280 | __end_cc_report 21:58:41 INFO - PROCESS | 6280 | __startTimestamp1475643521143__endTimestamp 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | ------- Summary: start ------- 21:58:41 INFO - PROCESS | 6280 | Number of tests: 14 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 21:58:41 INFO - PROCESS | 6280 | Values: 109.0 111.0 111.0 110.0 110.0 111.0 109.0 111.0 109.0 111.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:128.00 stddev:18.91 (14.8%) stddev-sans-first:19.33 21:58:41 INFO - PROCESS | 6280 | Values: 150.0 124.0 123.0 173.0 122.0 127.0 129.0 124.0 162.0 122.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.00 stddev:3.00 (1.9%) stddev-sans-first:3.10 21:58:41 INFO - PROCESS | 6280 | Values: 160.0 161.0 160.0 160.0 161.0 161.0 161.0 162.0 163.0 170.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:15.75 (20.9%) stddev-sans-first:16.45 21:58:41 INFO - PROCESS | 6280 | Values: 75.0 76.0 75.0 108.0 76.0 75.0 76.0 75.0 117.0 76.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:14.93 (18.2%) stddev-sans-first:15.47 21:58:41 INFO - PROCESS | 6280 | Values: 82.0 82.0 119.0 82.0 83.0 82.0 103.0 82.0 82.0 114.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 21:58:41 INFO - PROCESS | 6280 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 21:58:41 INFO - PROCESS | 6280 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:58:41 INFO - PROCESS | 6280 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.00 stddev:2.92 (5.6%) stddev-sans-first:3.10 21:58:41 INFO - PROCESS | 6280 | Values: 53.0 52.0 51.0 51.0 52.0 53.0 52.0 52.0 61.0 52.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.50 stddev:1.25 (2.0%) stddev-sans-first:1.30 21:58:41 INFO - PROCESS | 6280 | Values: 61.0 61.0 61.0 60.0 63.0 63.0 64.0 61.0 62.0 61.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:0.95 (1.2%) stddev-sans-first:0.88 21:58:41 INFO - PROCESS | 6280 | Values: 81.0 80.0 79.0 80.0 80.0 80.0 79.0 78.0 81.0 79.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:140.50 stddev:17.51 (12.5%) stddev-sans-first:18.33 21:58:41 INFO - PROCESS | 6280 | Values: 135.0 135.0 142.0 140.0 146.0 132.0 130.0 139.0 191.0 141.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:169.00 stddev:2.13 (1.3%) stddev-sans-first:2.15 21:58:41 INFO - PROCESS | 6280 | Values: 170.0 166.0 172.0 165.0 168.0 167.0 169.0 169.0 169.0 166.0 21:58:41 INFO - PROCESS | 6280 | 21:58:41 INFO - PROCESS | 6280 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:1.42 (2.1%) stddev-sans-first:1.48 21:58:41 INFO - PROCESS | 6280 | Values: 66.0 67.0 67.0 66.0 66.0 65.0 68.0 70.0 66.0 66.0 21:58:41 INFO - PROCESS | 6280 | -------- Summary: end -------- 21:58:41 INFO - PROCESS | 6280 | 21:58:42 INFO - TEST-INFO | 6280: exit 0 21:58:42 INFO - TEST-OK | kraken | took 62099ms 21:58:42 INFO - SUITE-END | took 1179s 21:58:42 INFO - Completed test suite (00:19:40) 21:58:42 INFO - javascript benchmark 21:58:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3026.6519350274716, 3058.1437197584683, 3075.3388021575365, 3103.3327834515576, 3108.922276943076, 5191.714455704935, 5261.105612045952, 5270.841874743759, 5338.306020217371, 5393.865153371167, 5238.0, 5300.628955973074, 5306.230596563496, 5309.30978972733, 5332.493413125757, 4809.759512024402, 4837.0, 4875.00062487191, 4875.561199492045, 4898.902021959559, 4860.684055536397, 4889.33993910821, 4913.26301054841, 4914.11545921734, 4972.328735620681, 4661.277501987163, 4882.926756098661, 4892.902141957141, 4944.258361245824, 4981.1532039553185, 4677.2750223715375, 4753.382060332169, 4811.230203167476, 4828.686135401188, 4867.075255701406, 4774.188387974053, 4779.784909679072, 4789.521047895218, 4790.520947905182, 4846.030793841246, 5247.239150323182, 5280.498352656491, 5289.264438296077, 5295.391030031518, 5300.628955973083, 5366.812161574326, 5409.134538473825, 5566.415526369754, 5634.154876768476, 5641.576881733887, 5679.630823996427, 5693.402192769741, 5695.117256825199, 5696.458836410576, 5757.963566558018, 5292.8412147635245, 5303.602229832778, 5304.098303288489, 5304.6286759926825, 5359.14253719403, 5481.588880833953, 5525.502704756591, 5726.885462290731, 5784.971075144597, 5812.38969908162, 5562.443755624486, 5566.443355664401, 5571.164325351148, 5626.0, 5637.830865074055, 5605.887882242332, 5645.491905728504, 5654.37801841797, 5656.830295091154, 5659.377468478464, 5455.809046683347, 5503.422140675251, 5521.420250873681, 5576.470235327637, 5644.153376993484, 5502.477264659851, 5545.77816887328, 5557.44425557441, 5577.05190117681, 5622.57830662702, 4299.656027517791, 4304.225239456865, 4304.4834619845815, 4308.870733877989, 4359.193549193409, 3748.0817199785683, 3767.453719210699, 3842.884713458601, 3865.1496670732395, 3920.0591857953887, 5328.094223981932, 5383.273258110184, 5386.057439947994, 5452.700101494456, 5514.338279406497, 5731.770729170787, 5739.0, 5741.1388291756575, 5742.253507044057, 5746.109353050284, 5173.4826517347965, 5383.43473935239, 5435.895913429399, 5445.2921120254905, 5454.7272636368025, 4757.690750101302, 4826.903461930812, 4892.951070489249, 4894.730789806595, 4984.675996060245, 5922.141289512911, 5932.940670593412, 5934.910976335358, 5938.465538101592, 5939.168516407706, 5647.519960803378, 5704.3154821421695, 5713.685747283939, 5719.971400143139, 5722.4277572242445, 5667.631603945731, 5735.11105778605, 5736.340320862987, 5879.265091863517, 6014.609050411709, 5570.470805273492, 5603.019471592536, 5654.519365853948, 5668.7732490701555, 5689.800856969986, 5700.600957933071, 5714.885702286014, 5720.227769251098, 5720.971395142998, 5724.026915424472, 5298.788048478172, 5332.946670533245, 5586.301712285965, 5587.664740115443, 5598.496135347838, 5497.917531237114, 5538.390777014606, 5564.805231816867, 5584.050711379156, 5650.773969041193, 5522.30971128609, 5524.696141712245, 5535.6955367455175, 5539.8892022160135, 5545.085060964896, 5228.693026083675, 5606.719664016864, 5613.550915926798, 5619.297587801525, 5619.775208991595, 5225.790968361223, 5299.39057008449, 5380.031594313061, 5416.485433883775, 5433.293671822637], "value": 5218.504590393451, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4224118123057, 602.9547783916206, 603.3815339277238, 620.9505934969903, 624.9093881387199, 32158.67841321586, 42629.360559591594, 43644.56355436449, 43648.78175609117, 46556.76721616387, 44850.0, 45219.32171017437, 45306.32040519395, 45314.78879928809, 45318.92129708325, 8208.753737387888, 8979.955100224506, 9150.816983660323, 9154.725358239264, 9159.725208243763, 8243.05204901438, 10554.155667546616, 10903.945480272587, 10908.34549927007, 11301.717457063556, 11165.609203677874, 11221.943890280538, 11226.101911847074, 11232.775344493106, 11236.887631123665, 8331.875021874677, 8535.274501667365, 10801.297915635458, 10858.402787846744, 10865.891341086566, 10380.792384152275, 10741.570337186504, 10744.409057501834, 11060.778784424267, 11070.225084244106, 42655.0, 43016.784916075536, 43050.13899721988, 43059.13881722379, 43092.78453607712, 3527.435610302365, 3584.5160903277983, 3595.694365978895, 3644.599094099647, 3666.7616604920595, 31316.0, 31859.84070079658, 31926.840365798256, 32225.0, 33434.66565334364, 4249.68127390447, 4409.162259170747, 4412.580804823537, 4448.266036104039, 4635.351050852883, 343550.0, 343685.0, 344532.0, 344556.0, 345205.0, 34434.0, 35452.64547354494, 55947.16079258815, 56306.43693563094, 56404.717976409855, 36870.63129368726, 37172.62827371692, 37208.813955930586, 37351.25297494035, 37471.43792843109, 13900.93049534766, 14003.339365520518, 14009.159450433006, 14010.85989140116, 14021.29893505341, 10527.0, 10755.247132700635, 11056.944715276533, 11489.138314626269, 11575.479103440366, 8376.41365104449, 8445.451045682012, 8592.183742544448, 8593.871091933626, 8606.956965215259, 3293.637699853014, 3361.5125806758374, 3389.1018879996823, 3417.79493230407, 3433.4163192257374, 987.4865070163474, 1071.5338827610015, 1101.6419663609358, 1129.2095533126844, 1140.4582823159099, 31886.84056579702, 31966.360672786413, 31989.0, 32110.197245068593, 32691.836540817145, 1033.788073444942, 1087.8694556653252, 1095.5179720922768, 1109.8723646780722, 1135.0465608888574, 15230.543083707507, 16309.51071467858, 16350.83649163517, 16436.63926232073, 16458.42395516151, 507216.0, 512507.87429131556, 513340.0, 514081.0, 514134.0, 55069.44930550643, 55340.44659553433, 55412.445875540725, 55431.44568554343, 56030.719846400505, 1223.6573759347398, 1281.3080936294482, 1303.7457695749617, 1341.7450684370133, 1347.2253454263837, 29015.564766528096, 32380.514292286105, 32684.0, 32754.0, 33058.66941330556, 48600.75699621479, 49170.262446062625, 49173.0, 49222.75388623034, 49448.50551494439, 411345.0, 414974.0, 415244.0, 415478.0, 416011.0, 27375.315617108936, 27442.725572744017, 28570.714292857636, 28607.856960715897, 29465.852670737368, 43246.78376608097, 43720.0, 43756.78121609372, 43868.78065609652, 44772.77613611911, 37133.81433092817, 37421.81289093537, 38010.23979520449, 38058.42912356372, 39509.2098158041, 37824.62175378211, 37901.631546873694, 37923.0, 38523.0, 39339.409908851965, 37667.24665506729, 38140.0, 38412.42381364338, 38875.0, 39061.2187756249, 32144.0, 34299.65700343064, 34608.0, 34820.30359392849, 34862.65137348594, 26509.469810603296, 26865.0, 26889.327766805985, 26897.462050759266, 27079.1876243713], "value": 18788.697659935307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.98645547405846, 393.5159753503191, 405.54173783624503, 406.73562184580027, 428.6742076022222, 13260.403281852316, 15312.617184570392, 18561.257549698013, 18909.43271701851, 19149.04254787262, 18902.338418155367, 19257.807421925776, 19341.4197574073, 19415.32046378377, 19455.124519396624, 4860.125177468054, 5498.972505137479, 5724.398938111501, 5728.79949201778, 5734.655920644754, 5482.424345443731, 5573.6098473106895, 5578.944210557904, 5583.3300003999575, 5583.6928968906695, 5418.91871621926, 5423.538999185074, 5543.223948647193, 5548.77804887804, 5548.833534993957, 5515.062439385314, 5516.834494965137, 5556.638818476807, 5558.749856256478, 5596.720163991784, 5028.270900719375, 5054.393472783289, 5060.645754797166, 5060.696358218482, 5305.761240744176, 13976.720465590632, 14251.501197458143, 14254.144751314954, 14265.358058887376, 21204.257850975297, 2184.7924447177493, 2214.3799736073925, 2287.8055365293803, 2583.7803786678155, 2681.3564744461382, 9903.108720215143, 10109.34289271195, 10136.847947280796, 10651.573937042509, 10774.676759697222, 1804.3865085870736, 1884.180381534037, 1891.990540047291, 1896.5637903282184, 1920.6446807340546, 79467.0, 80461.0, 83179.0, 84891.0, 85259.57370213109, 10434.530446129942, 10659.147268218523, 10668.679939601825, 11254.887451125383, 11881.465334059989, 15895.364185432685, 15915.522534323989, 15964.600884977968, 15965.600859978593, 15978.840211597735, 7261.2572982483825, 7423.1092268927, 7458.291462311072, 7563.697452101855, 7580.772576822704, 6981.162260528769, 7016.894746578805, 7017.543859649209, 7071.964640176766, 7235.095613048369, 4706.599939005155, 4765.76171191446, 4826.203676393356, 4860.975695121501, 4899.755012249373, 1918.5299601597699, 1986.3147214211074, 1997.8423302832905, 2032.89835508224, 2055.270379015458, 830.5722552885269, 961.2262128986233, 995.2734503812258, 1042.760165162017, 1045.6444808764904, 17703.0, 19537.609247814966, 19540.413787586396, 20775.68836467454, 20927.688436713815, 931.3387494878576, 942.0391200974967, 947.4457442396138, 976.8485884687884, 1050.2805578178973, 10306.690799276033, 10640.680779576625, 10791.352518848895, 10845.295055821347, 10913.126949843994, 341784.0, 341819.0, 342784.0, 438168.0, 440943.0, 88334.0, 92040.53979730059, 92329.5383523078, 92495.53752231196, 94099.0, 997.5112195024386, 998.5955687946393, 1037.9325343852624, 1044.3733759744093, 1051.4690081508788, 16562.917185413997, 17032.318707251572, 17321.91339043347, 17375.391861284796, 17414.129293535527, 39613.0, 39716.80141599273, 39764.42709088492, 40526.39210411787, 41525.58474415338, 50939.0, 51396.0, 56756.0, 57210.281331713304, 58125.12812307734, 7928.643211055401, 8428.704995325133, 8466.492010479391, 8565.186307300797, 8790.0, 12316.0, 12342.444589993293, 12837.42231599599, 12974.416151273404, 13607.931960340135, 5651.321841378896, 7879.724209652634, 9378.531073446436, 10733.195010374096, 11432.314061156358, 10648.148148148284, 10687.412192329497, 10799.568017279535, 10880.510377033212, 10889.618863339745, 11228.157888158585, 11250.493727782106, 11326.490307936327, 11378.772424551627, 12092.697682558006, 8370.204830541088, 8382.538960356995, 8444.915550844413, 8546.273566746897, 8725.650973961225, 9858.901410985798, 11314.264572802742, 11632.360220187971, 11636.069114470652, 11834.46744896499], "value": 8811.293393873193, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.2573584528507, 1472.0946617830039, 1496.9625759356015, 1644.4408900973667, 1768.7523746675467, 7741.8838717419285, 8759.824803503927, 9088.591013404397, 9099.90900090999, 9374.343795934288, 9108.544572771352, 9202.401843880143, 9207.585658645361, 9209.0, 9212.861807072883, 2386.653935179402, 2421.7699318564796, 2421.83047186697, 2424.4302588891596, 2427.635854621803, 2338.1348900906687, 2374.8456350337174, 2403.267003563912, 2406.3863714752715, 2407.3861165402886, 2379.1553998330605, 2397.9640305395433, 2404.206611818096, 2413.8431001984814, 2420.576399130154, 2286.9199578014855, 2289.599320118981, 2292.0946226240626, 2293.20884294918, 2339.2748248043163, 2227.0646328542052, 2231.866088034723, 2234.843560950734, 2235.698180745595, 2242.439390152462, 8890.244329232022, 8976.371653984224, 8993.190612844875, 9016.098390160996, 9067.501287429188, 5295.920561191547, 5442.809501667422, 5511.118221084607, 5511.448855114497, 5513.972430137864, 3719.75821571597, 3723.3484140275614, 3730.1234209960908, 3786.962130378716, 3805.7145714071557, 1206.3546002888413, 1209.2260952990093, 1218.585680868509, 1244.4959791284543, 1258.9559365422258, 12706.04704647155, 12718.554850580185, 12795.488180472863, 12868.420921058574, 12877.034222433262, 4535.63714902807, 4700.2009658358165, 4817.78319975602, 4825.372701548777, 4878.9512104878495, 9891.653792117242, 9895.158911492459, 9898.80202395948, 9901.158401535806, 9905.900940990497, 5532.917006244909, 5552.833414997475, 5558.861028474321, 5558.916616250759, 5559.138333558305, 4498.077894031781, 4656.5110663379855, 4949.925751113737, 5089.0, 5172.9741351293005, 3893.104585945192, 4018.1561872007205, 4054.3107671695884, 4059.7767122808527, 4083.305838007546, 1245.5080243303844, 1249.3503378243263, 1254.1346470935025, 1261.6782720406238, 1267.87955144263, 926.972190834276, 978.2760757039739, 982.1946004276425, 995.7659949911765, 1004.6885465505717, 6075.840562907263, 6103.542234332443, 6143.6928153593035, 6191.25704915413, 6216.316205217422, 477.5773440505109, 478.1298037571656, 488.63840757838943, 501.9171836646912, 503.26272011503323, 4140.855070072533, 4249.79789007219, 4323.935140972888, 4365.9126817463475, 4444.288913773846, 11118.555257789598, 11442.427878606037, 11469.71325716847, 11486.0, 11496.0, 11285.830712539318, 11286.266392684449, 11302.604408845651, 11345.0, 11345.432728363548, 8062.516249025077, 8284.50292982423, 8365.623546940402, 8415.873761893576, 8446.408751387467, 6025.909611355921, 6365.04524321337, 6395.936040639534, 6417.518686098655, 6481.0, 9886.85169722469, 10630.0, 10638.202134840072, 10670.679879603624, 10676.679699609023, 10495.895041049796, 10625.468726563795, 10672.986066323687, 10784.946075269574, 10799.892001079888, 6973.372396484341, 7094.116132354688, 7541.095068591804, 7990.320822730133, 8150.510969341622, 8726.3891527595, 8831.91168088311, 8841.16008979146, 8871.733847984571, 8913.598888049924, 7608.923910761043, 7630.618469076413, 7770.611469426619, 7865.292123708894, 8182.386321025828, 7482.775516734507, 7585.886211706718, 7597.2022937590755, 7652.655630496753, 7692.730754423568, 7084.681189346595, 7194.748183813542, 7198.8920166198595, 7199.532030418006, 7215.314545118205, 5201.6098792591465, 5240.659357141773, 5281.894362112813, 5285.973570132125, 5523.696196709059, 5362.222477740784, 5382.138857782736, 5452.91820622683, 5484.533814625802, 5595.972020139873], "value": 4677.698907465255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.02683719879377, 336.2468071519796, 346.84912063252494, 347.80001499137984, 351.2080259015919, 5193.45468725784, 5242.475752424755, 5325.573954083674, 5344.866378340544, 5391.838244852655, 5136.255242989773, 5220.4779522047775, 5238.585581892887, 5272.393674727407, 5276.3668359796875, 4176.2900306947895, 4186.39297301891, 4194.433751443562, 4196.328587426013, 4200.285951388271, 3984.86052988144, 4121.793910304487, 4188.246115699173, 4192.685548583853, 4202.789860506978, 4094.7133700640966, 4099.836006559749, 4103.774292413916, 4107.404426358176, 4116.855910043149, 4100.2414553307735, 4111.527174374955, 4113.0, 4130.256553820311, 4133.565975572552, 3622.040159357772, 3626.165981824195, 3640.7451478396524, 3657.9817100914324, 3662.853485860562, 5096.694198348111, 5119.257707632372, 5140.948590514085, 5147.0, 5169.707573106723, 4693.671442998992, 4699.107169637758, 4702.4716966985525, 4704.95295047052, 4711.717296962193, 5427.592930530186, 5438.265834112383, 5454.563634909197, 5454.809081682161, 5455.890882182373, 3756.0, 3944.9013774655577, 3959.4060890866313, 3960.3069462844173, 3964.7224694271413, 5698.373178950312, 5734.655920644733, 5736.42635736423, 5737.483626473638, 5744.253247077853, 4060.2285565742413, 4093.5906409358827, 4107.466029416157, 4121.9587804121575, 4129.566395528486, 3942.5071866016747, 4100.569440208735, 4125.525564560054, 4147.294959856831, 4185.455890734246, 4678.6491013174145, 4693.0, 4703.670743047954, 4707.7175369477945, 4721.716696998191, 5494.1758736189895, 5524.116141417354, 5529.82035329687, 5564.4991950724625, 5611.971940140274, 1330.8003799430162, 1351.3243378310844, 1357.5520078374311, 1398.0, 1401.537492627451, 899.6941040046415, 905.343625871238, 916.2532535983153, 927.5037854747677, 941.5104145844123, 4673.551199128281, 4678.95321046792, 4680.789364478538, 4698.530146985342, 4735.3537775912355, 4851.563359297609, 4863.489333619919, 4903.975480122576, 4916.729579873141, 4930.09124616478, 4672.345871577982, 4683.976580117078, 4688.5619477872, 4691.0, 4714.481407045222, 2780.694123646397, 2936.6329208848892, 2967.9908830997565, 2970.212893583202, 2989.880404783828, 5851.619644723164, 5852.946469635506, 5872.530197584183, 5873.647581145145, 5915.704214789243, 5525.640833345819, 5729.369769325371, 5748.390450673818, 5791.420857914259, 5841.795537156179, 5839.299284085937, 5879.206307148565, 5882.705864706748, 5891.293044834647, 5903.4686878179455, 5639.3232812062815, 5643.633163844337, 5654.85862853432, 5698.287714035746, 5719.513841323368, 5357.258890860564, 5550.389457159628, 5568.49883510486, 5573.359063707726, 5576.553875690016, 5861.501772349398, 5866.67733274674, 5876.676782776988, 5878.441548052928, 5919.644821310735, 4021.819018144132, 4062.1469491407133, 4075.65356944663, 4078.9796051020744, 4079.2255368914616, 5368.40947495783, 5602.915956260578, 5633.267675202197, 5652.152177173457, 5659.773609055756, 5332.493413125747, 5400.324959380077, 5461.972690136524, 5510.173473978935, 5519.172124181405, 5477.452254774491, 5481.643693159932, 5521.309836270466, 5529.253550770594, 5532.391436941853, 5264.0259902536545, 5408.864778380572, 5447.945520544744, 5469.863253418696, 5487.945120548743, 5488.670679759227, 5494.681276493693, 5495.884084627367, 5525.585581081516, 5525.972370138124, 5425.755840987244, 5428.511433970962, 5438.809641662523, 5451.836444906659, 5467.863303417446], "value": 4169.221580033645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.601731039273, 744.6611791634807, 766.1916677904811, 793.3217099380029, 821.6056292979368, 14800.259987000647, 15817.050976941391, 15825.129617871013, 15853.445129420472, 15966.0, 13687.726245475085, 14682.265886705649, 14824.6293842654, 14831.406743730238, 14854.33155508002, 784.9293563579276, 805.8267472493412, 806.8547661420971, 808.2564041082219, 808.8827120067587, 662.2053535757086, 681.5603935461625, 783.8510682970245, 811.8701007838747, 816.5631387207845, 837.8563261148519, 845.8984921809391, 850.4514588090677, 850.6469815026757, 851.8764779107025, 839.8698201778673, 840.5923127283263, 841.3017195727532, 841.7727213652311, 843.7890527368158, 502.5200933108872, 519.1045446604614, 520.9088409528317, 620.512897375558, 621.0808004153878, 12530.874691253153, 13594.728105437836, 14107.717845643132, 14122.152670839783, 14606.342714577764, 14665.56003319902, 15047.247637618184, 15505.379784808707, 15525.0, 15956.281967311383, 12213.104180517419, 12255.448504817305, 12292.262464252173, 12465.563705270362, 13026.739465210738, 3897.162110146304, 3912.7456715313415, 4055.655269302113, 4115.54728979812, 4116.073883376246, 82506.58746706288, 82773.17226827654, 83829.58085209534, 83858.58070709607, 83928.58035709782, 11125.554977800959, 11239.381833999209, 11243.269187502787, 11315.490802913888, 11442.313461192354, 23309.0, 23402.64896026561, 23442.882785585964, 23459.648105278433, 23949.16177933799, 8457.323414126855, 8597.871031934526, 8600.5699715014, 8741.868871966799, 8786.297096232285, 4602.953970460319, 4799.328094066834, 4809.134355815987, 4872.342233798463, 4906.411230652345, 3738.32710112177, 3815.923681526354, 3869.806509674505, 3879.243547508209, 3881.476000739864, 612.6109920200705, 627.209715758148, 632.5761739634456, 640.4684112186874, 645.854682696399, 641.8780431717959, 650.677914432359, 680.0071895033208, 712.9928700713031, 741.588418427767, 9096.317776166814, 9749.268804839665, 9900.158486528582, 10101.69694909154, 10181.287309888385, 723.2622724820653, 734.1667207719171, 744.7132853851198, 751.305042835375, 755.0637209859734, 4631.698939568917, 5032.521910418504, 5036.471170527115, 5046.243063540498, 5090.421303656627, 103055.96944030463, 118759.0, 120243.0, 122037.0, 122324.38837805932, 99229.0, 103156.48421757843, 103992.48003760084, 108522.0, 109073.0, 88533.0, 88756.11243887608, 89359.55320223357, 90325.54837225772, 91276.0468743755, 9343.813123737624, 9583.568739406604, 9605.135537801352, 9641.42151470914, 9676.70969870905, 53763.73118134384, 54583.0, 54692.72653636707, 56131.15803263036, 56507.71746141243, 74282.0, 75976.62011689907, 76772.23227767875, 78763.60618196872, 83273.0, 12925.438224448848, 13063.412146453622, 13073.496547897113, 13178.934105329796, 13399.866001339862, 14628.488002919847, 15145.848541514444, 15147.396822224267, 15599.0, 16134.273957671698, 13888.418852336716, 14297.481466689796, 14830.629234268798, 15130.243487825785, 15308.928375013642, 14284.642883927985, 14353.138811670915, 14587.635309116933, 14845.33196006204, 15420.614484637974, 13612.902586659487, 14115.153090814583, 14560.271986400849, 14572.125672459686, 15020.399184032516, 11319.490622921823, 11445.370504622326, 11454.427278635869, 11642.76714465723, 11715.882841171479, 11782.764344713229, 11943.701407464883, 11945.283283003047, 12028.518859245532, 12250.203736757083], "value": 7734.70157813036, "unit": "score"}], "name": "dromaeo_css", "value": 7120.481111219498, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 111.0, 110.0, 110.0, 111.0, 109.0, 111.0, 109.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 123.0, 173.0, 122.0, 127.0, 129.0, 124.0, 162.0, 122.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 162.0, 163.0, 170.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 108.0, 76.0, 75.0, 76.0, 75.0, 117.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 119.0, 82.0, 83.0, 82.0, 103.0, 82.0, 82.0, 114.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 51.0, 52.0, 53.0, 52.0, 52.0, 61.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 63.0, 63.0, 64.0, 61.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 80.0, 80.0, 80.0, 79.0, 78.0, 81.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 142.0, 140.0, 146.0, 132.0, 130.0, 139.0, 191.0, 141.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 172.0, 165.0, 168.0, 167.0, 169.0, 169.0, 169.0, 166.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 65.0, 68.0, 70.0, 66.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1513.1, "alertThreshold": 2.0}]} 21:58:42 INFO - Return code: 0 21:58:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:58:42 INFO - # TBPL SUCCESS # 21:58:42 INFO - Running post-action listener: _resource_record_post_action 21:58:42 INFO - [mozharness: 2016-10-05 04:58:42.956418Z] Finished run-tests step (success) 21:58:42 INFO - Running post-run listener: _resource_record_post_run 21:58:43 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404418560; Read time: 12; Write time: 276816 21:58:43 INFO - TinderboxPrint: CPU usage
13.1% 21:58:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:58:43 INFO - TinderboxPrint: I/O write bytes / time
404,418,560 / 276,816 21:58:43 INFO - TinderboxPrint: CPU idle
8,309.9 (86.9%) 21:58:43 INFO - TinderboxPrint: CPU user
1,199.7 (12.5%) 21:58:43 INFO - TinderboxPrint: Swap in / out
0 / 0 21:58:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103788544; Read time: 0; Write time: 99856 21:58:43 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288915456; Read time: 0; Write time: 173508 21:58:43 INFO - Running post-run listener: _upload_blobber_files 21:58:43 INFO - Blob upload gear active. 21:58:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:58:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:58:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:58:43 INFO - (blobuploader) - INFO - Open directory for files ... 21:58:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:58:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:44 INFO - (blobuploader) - INFO - Done attempting. 21:58:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:58:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:58:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:45 INFO - (blobuploader) - INFO - Done attempting. 21:58:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:58:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:58:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:48 INFO - (blobuploader) - INFO - Done attempting. 21:58:48 INFO - (blobuploader) - INFO - Iteration through files over. 21:58:48 INFO - Return code: 0 21:58:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:58:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:58:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5227ea7b24db54de1698d9dd83beeb83b44832465560565d9c247fc1a75a2c5d6a0e9ef4d5f11055b45a5ba8690f24e00bedb38b0f0aaffca7f343252be47d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa1958a2b3fbd5213f74de21d5afbeaf858392c30b7ef535db4f4aa2de3e8fafb8977f0ca3b74eebe9801d23ea5620fb1dd98edb399295812750a4d50070dd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b4da6b40db8489e9cc9b42676e48bcdbd152054e330e3defae0e1c925a188a46049df26d3b53fa8d4143f75e38a41cad698a66d1d7b1e7749a35da0bbfa119e"} 21:58:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:58:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:58:48 INFO - Contents: 21:58:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5227ea7b24db54de1698d9dd83beeb83b44832465560565d9c247fc1a75a2c5d6a0e9ef4d5f11055b45a5ba8690f24e00bedb38b0f0aaffca7f343252be47d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa1958a2b3fbd5213f74de21d5afbeaf858392c30b7ef535db4f4aa2de3e8fafb8977f0ca3b74eebe9801d23ea5620fb1dd98edb399295812750a4d50070dd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b4da6b40db8489e9cc9b42676e48bcdbd152054e330e3defae0e1c925a188a46049df26d3b53fa8d4143f75e38a41cad698a66d1d7b1e7749a35da0bbfa119e"} 21:58:48 INFO - Running post-run listener: copy_logs_to_upload_dir 21:58:48 INFO - Copying logs to upload dir... 21:58:48 INFO - mkdir: /builds/slave/test/build/upload/logs 21:58:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.308204 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-04 21:58:48.930992) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 21:58:48.934598) ========= 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=41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5227ea7b24db54de1698d9dd83beeb83b44832465560565d9c247fc1a75a2c5d6a0e9ef4d5f11055b45a5ba8690f24e00bedb38b0f0aaffca7f343252be47d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa1958a2b3fbd5213f74de21d5afbeaf858392c30b7ef535db4f4aa2de3e8fafb8977f0ca3b74eebe9801d23ea5620fb1dd98edb399295812750a4d50070dd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b4da6b40db8489e9cc9b42676e48bcdbd152054e330e3defae0e1c925a188a46049df26d3b53fa8d4143f75e38a41cad698a66d1d7b1e7749a35da0bbfa119e"} build_url:https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011533 build_url: 'https://queue.taskcluster.net/v1/task/HKYUcS24RDijALaidsFNpg/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/Fx-Team/sha512/f5227ea7b24db54de1698d9dd83beeb83b44832465560565d9c247fc1a75a2c5d6a0e9ef4d5f11055b45a5ba8690f24e00bedb38b0f0aaffca7f343252be47d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1aa1958a2b3fbd5213f74de21d5afbeaf858392c30b7ef535db4f4aa2de3e8fafb8977f0ca3b74eebe9801d23ea5620fb1dd98edb399295812750a4d50070dd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b4da6b40db8489e9cc9b42676e48bcdbd152054e330e3defae0e1c925a188a46049df26d3b53fa8d4143f75e38a41cad698a66d1d7b1e7749a35da0bbfa119e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 21:58:48.960136) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:58:48.960462) ========= 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=41bf3e9aed84707956354da8000001c5-1475642286.912524-2137900841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:58:49.045085) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 21:58:49.045419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 21:58:49.045703) ========= ========= Total master_lag: 0.17 =========