builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1475308664.62 results: success (0) buildid: 20160930232556 builduid: 06250708edb248db926db7f4505e316d revision: fcc62bbf09eecabf27c8d198d5d3719e16b296ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:44.619935) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:44.620413) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:44.620697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:44.654605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:44.654959) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-01 00:57:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.5M=0s 2016-10-01 00:57:44 (64.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181125 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:45.036118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:45.039490) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009225 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:45.056875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 00:57:45.060306) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fcc62bbf09eecabf27c8d198d5d3719e16b296ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fcc62bbf09eecabf27c8d198d5d3719e16b296ea --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=5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-01 00:57:45,109 truncating revision to first 12 chars 2016-10-01 00:57:45,110 Setting DEBUG logging. 2016-10-01 00:57:45,110 attempt 1/10 2016-10-01 00:57:45,110 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fcc62bbf09ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 00:57:46,004 unpacking tar archive at: mozilla-central-fcc62bbf09ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.233898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 00:57:46.306194) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:46.306521) ========= script_repo_revision: fcc62bbf09eecabf27c8d198d5d3719e16b296ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:46.306978) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:46.307277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 00:57:46.316485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-10-01 00:57:46.316901) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:57:46 INFO - MultiFileLogger online at 20161001 00:57:46 in /builds/slave/test 00:57:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 00:57:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:57:46 INFO - {'append_to_log': False, 00:57:46 INFO - 'base_work_dir': '/builds/slave/test', 00:57:46 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 00:57:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:57:46 INFO - 'branch': 'Firefox-Non-PGO', 00:57:46 INFO - 'buildbot_json_path': 'buildprops.json', 00:57:46 INFO - 'config_files': ('talos/linux_config.py',), 00:57:46 INFO - 'default_actions': ('clobber', 00:57:46 INFO - 'read-buildbot-config', 00:57:46 INFO - 'download-and-extract', 00:57:46 INFO - 'populate-webroot', 00:57:46 INFO - 'create-virtualenv', 00:57:46 INFO - 'install', 00:57:46 INFO - 'run-tests'), 00:57:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:57:46 INFO - 'download_minidump_stackwalk': True, 00:57:46 INFO - 'download_symbols': 'ondemand', 00:57:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:57:46 INFO - 'tooltool.py': '/tools/tooltool.py', 00:57:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:57:46 INFO - '/tools/misc-python/virtualenv.py')}, 00:57:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:57:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:57:46 INFO - 'installer_path': 'installer.exe', 00:57:46 INFO - 'log_level': 'info', 00:57:46 INFO - 'log_name': 'talos', 00:57:46 INFO - 'log_to_console': True, 00:57:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:57:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:57:46 INFO - 'opt_config_files': (), 00:57:46 INFO - 'pip_index': False, 00:57:46 INFO - 'sps_profile': False, 00:57:46 INFO - 'sps_profile_interval': 0, 00:57:46 INFO - 'suite': 'dromaeojs', 00:57:46 INFO - 'system_bits': '32', 00:57:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:57:46 INFO - 'title': 'talos-linux64-ix-051', 00:57:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:57:46 INFO - 'use_talos_json': True, 00:57:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:57:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:57:46 INFO - 'work_dir': 'build'} 00:57:46 INFO - [mozharness: 2016-10-01 07:57:46.624310Z] Running clobber step. 00:57:46 INFO - Running pre-action listener: _resource_record_pre_action 00:57:46 INFO - Running main action method: clobber 00:57:46 INFO - rmtree: /builds/slave/test/build 00:57:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:57:47 INFO - Running post-action listener: _resource_record_post_action 00:57:47 INFO - [mozharness: 2016-10-01 07:57:47.034348Z] Finished clobber step (success) 00:57:47 INFO - [mozharness: 2016-10-01 07:57:47.034448Z] Running read-buildbot-config step. 00:57:47 INFO - Running pre-action listener: _resource_record_pre_action 00:57:47 INFO - Running main action method: read_buildbot_config 00:57:47 INFO - Using buildbot properties: 00:57:47 INFO - { 00:57:47 INFO - "project": "", 00:57:47 INFO - "product": "firefox", 00:57:47 INFO - "script_repo_revision": "production", 00:57:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 00:57:47 INFO - "repository": "", 00:57:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 00:57:47 INFO - "buildid": "20160930232556", 00:57:47 INFO - "pgo_build": "False", 00:57:47 INFO - "basedir": "/builds/slave/test", 00:57:47 INFO - "buildnumber": 227, 00:57:47 INFO - "slavename": "talos-linux64-ix-051", 00:57:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:57:47 INFO - "platform": "ubuntu64_hw", 00:57:47 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 00:57:47 INFO - "branch": "mozilla-central", 00:57:47 INFO - "repo_path": "mozilla-central", 00:57:47 INFO - "revision": "fcc62bbf09eecabf27c8d198d5d3719e16b296ea", 00:57:47 INFO - "stage_platform": "linux64", 00:57:47 INFO - "builduid": "06250708edb248db926db7f4505e316d", 00:57:47 INFO - "slavebuilddir": "test" 00:57:47 INFO - } 00:57:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:57:47 INFO - Running post-action listener: _resource_record_post_action 00:57:47 INFO - [mozharness: 2016-10-01 07:57:47.036885Z] Finished read-buildbot-config step (success) 00:57:47 INFO - [mozharness: 2016-10-01 07:57:47.036974Z] Running download-and-extract step. 00:57:47 INFO - Running pre-action listener: _resource_record_pre_action 00:57:47 INFO - Running main action method: download_and_extract 00:57:47 INFO - mkdir: /builds/slave/test/build/tests 00:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:47 INFO - trying https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:57:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/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 00:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/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 00:57:47 INFO - Downloaded 1361 bytes. 00:57:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:57:47 INFO - Using the following test package requirements: 00:57:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:57:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:57:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:57:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:47 INFO - u'jsshell-linux-x86_64.zip'], 00:57:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:57:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:57:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:57:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:57:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:57:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:57:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:57:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:57:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:57:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:57:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:57:48 INFO - Http code: 200 00:57:48 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 00:57:48 INFO - x-amz-cf-id: bBk0_7YUIYyKbbHy3GlCauYjPicJ9okcZ2CCSEDpoqEj9fOz29SR4w== 00:57:48 INFO - x-amz-version-id: ALjcjp1OqtF7rXYMTKqmCLbfwHQga3V8 00:57:48 INFO - Expected file size: 20419321 00:57:48 INFO - Obtained file size: 20419321 00:57:52 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 00:57:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:57:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:57:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:57:52 INFO - Http code: 200 00:57:52 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 00:57:52 INFO - x-amz-cf-id: Hrrx6u94rq1i28LIbbNKMaZNqWDiVK-AmEBb6PR6KWyIBXwmQNX3Bg== 00:57:52 INFO - x-amz-version-id: ALjcjp1OqtF7rXYMTKqmCLbfwHQga3V8 00:57:53 INFO - Expected file size: 20419321 00:57:53 INFO - Obtained file size: 20419321 00:57:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:57:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:57:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:57:58 INFO - Http code: 200 00:57:58 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 00:57:58 INFO - x-amz-cf-id: H8suS774NYkbmSaYLR3CQp0IGMHy84-jaVwRD5ZQDQ-CSNQukncwXw== 00:57:58 INFO - x-amz-version-id: bftLqJcF_IcUkJqfsroilHXTU5w82AOI 00:57:58 INFO - Expected file size: 14408522 00:57:58 INFO - Obtained file size: 14408522 00:57:58 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')]} 00:57:58 INFO - trying https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:57:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/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 00:57:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/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 00:58:00 INFO - Downloaded 55732015 bytes. 00:58:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:58:00 INFO - mkdir: /builds/slave/test/properties 00:58:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:58:00 INFO - Writing to file /builds/slave/test/properties/build_url 00:58:00 INFO - Contents: 00:58:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:58:00 INFO - Running post-action listener: _resource_record_post_action 00:58:00 INFO - Running post-action listener: set_extra_try_arguments 00:58:00 INFO - [mozharness: 2016-10-01 07:58:00.934726Z] Finished download-and-extract step (success) 00:58:00 INFO - [mozharness: 2016-10-01 07:58:00.934950Z] Running populate-webroot step. 00:58:00 INFO - Running pre-action listener: _resource_record_pre_action 00:58:00 INFO - Running main action method: populate_webroot 00:58:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:58:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:58:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:58:00 INFO - '--tppagecycles', 00:58:00 INFO - '7'], 00:58:00 INFO - 'tests': ['tsvgm']}}, 00:58:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:58:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:58:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:58:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:58:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:00 INFO - 'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:58:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:58:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:00 INFO - 'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['damp', 'tps']}, 00:58:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:00 INFO - 'tests': ['damp', 'tps']}, 00:58:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['dromaeo_dom']}, 00:58:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:58:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['basic_compositor_video']}, 00:58:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:58:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['a11yr', 00:58:00 INFO - 'ts_paint', 00:58:00 INFO - 'tpaint', 00:58:00 INFO - 'sessionrestore', 00:58:00 INFO - 'sessionrestore_no_auto_restore', 00:58:00 INFO - 'tabpaint']}, 00:58:00 INFO - 'other-e10s': {'tests': ['a11yr', 00:58:00 INFO - 'ts_paint', 00:58:00 INFO - 'tpaint', 00:58:00 INFO - 'sessionrestore', 00:58:00 INFO - 'sessionrestore_no_auto_restore', 00:58:00 INFO - 'tabpaint']}, 00:58:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:58:00 INFO - 'ts_paint', 00:58:00 INFO - 'tpaint', 00:58:00 INFO - 'sessionrestore', 00:58:00 INFO - 'sessionrestore_no_auto_restore', 00:58:00 INFO - 'tabpaint']}, 00:58:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:58:00 INFO - 'ts_paint', 00:58:00 INFO - 'tpaint', 00:58:00 INFO - 'sessionrestore', 00:58:00 INFO - 'sessionrestore_no_auto_restore', 00:58:00 INFO - 'tabpaint']}, 00:58:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['a11yr', 00:58:00 INFO - 'ts_paint', 00:58:00 INFO - 'tpaint', 00:58:00 INFO - 'sessionrestore', 00:58:00 INFO - 'sessionrestore_no_auto_restore', 00:58:00 INFO - 'tabpaint']}, 00:58:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['a11yr', 00:58:00 INFO - 'ts_paint', 00:58:00 INFO - 'tpaint', 00:58:00 INFO - 'sessionrestore', 00:58:00 INFO - 'sessionrestore_no_auto_restore', 00:58:00 INFO - 'tabpaint']}, 00:58:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['tsvgx', 00:58:00 INFO - 'tsvgr_opacity', 00:58:00 INFO - 'tart', 00:58:00 INFO - 'tscrollx', 00:58:00 INFO - 'cart']}, 00:58:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:58:00 INFO - 'tsvgr_opacity', 00:58:00 INFO - 'tart', 00:58:00 INFO - 'tscrollx', 00:58:00 INFO - 'cart']}, 00:58:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:00 INFO - 'talos_options': ['--disable-e10s'], 00:58:00 INFO - 'tests': ['tp5o']}, 00:58:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:00 INFO - 'tests': ['tp5o']}, 00:58:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:00 INFO - 'talos_options': ['--disable-e10s', 00:58:00 INFO - '--xperf_path', 00:58:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:58:00 INFO - 'tests': ['tp5n']}, 00:58:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:58:00 INFO - 'talos_options': ['--xperf_path', 00:58:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:58:00 INFO - 'tests': ['tp5n']}}, 00:58:00 INFO - 'talos.zip': {'path': '', 00:58:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:58:00 INFO - Running post-action listener: _resource_record_post_action 00:58:00 INFO - [mozharness: 2016-10-01 07:58:00.951026Z] Finished populate-webroot step (success) 00:58:00 INFO - [mozharness: 2016-10-01 07:58:00.951113Z] Running create-virtualenv step. 00:58:00 INFO - Running pre-action listener: _resource_record_pre_action 00:58:00 INFO - Running main action method: create_virtualenv 00:58:00 INFO - Creating virtualenv /builds/slave/test/build/venv 00:58:00 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 00:58:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:58:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:58:01 INFO - Using real prefix '/usr' 00:58:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:58:02 INFO - Installing distribute.............................................................................................................................................................................................done. 00:58:04 INFO - Installing pip.................done. 00:58:04 INFO - Return code: 0 00:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:58:05 INFO - Reading from file tmpfile_stdout 00:58:05 INFO - Output received: 00:58:05 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) 00:58:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:58:05 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')]} 00:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:05 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')]} 00:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:05 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 0x7f2c2294af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', '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 00:58:05 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 00:58:05 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 00:58:05 INFO - Using env: {'DISPLAY': ':0', 00:58:05 INFO - 'HOME': '/home/cltbld', 00:58:05 INFO - 'LANG': 'en_US.UTF-8', 00:58:05 INFO - 'LANGUAGE': 'en_US:en', 00:58:05 INFO - 'LOGNAME': 'cltbld', 00:58:05 INFO - 'MAIL': '/var/mail/cltbld', 00:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:05 INFO - 'MOZ_NO_REMOTE': '1', 00:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:05 INFO - 'NO_EM_RESTART': '1', 00:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:05 INFO - 'PWD': '/builds/slave/test', 00:58:05 INFO - 'SHELL': '/bin/bash', 00:58:05 INFO - 'SHLVL': '1', 00:58:05 INFO - 'TERM': 'linux', 00:58:05 INFO - 'TMOUT': '86400', 00:58:05 INFO - 'USER': 'cltbld', 00:58:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:05 INFO - '_': '/tools/buildbot/bin/python'} 00:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:05 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 00:58:05 INFO - Cleaning up... 00:58:05 INFO - Return code: 0 00:58:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:58:05 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')]} 00:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:05 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')]} 00:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:05 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 0x7f2c2294af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', '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 00:58:05 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 00:58:05 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 00:58:05 INFO - Using env: {'DISPLAY': ':0', 00:58:05 INFO - 'HOME': '/home/cltbld', 00:58:05 INFO - 'LANG': 'en_US.UTF-8', 00:58:05 INFO - 'LANGUAGE': 'en_US:en', 00:58:05 INFO - 'LOGNAME': 'cltbld', 00:58:05 INFO - 'MAIL': '/var/mail/cltbld', 00:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:05 INFO - 'MOZ_NO_REMOTE': '1', 00:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:05 INFO - 'NO_EM_RESTART': '1', 00:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:05 INFO - 'PWD': '/builds/slave/test', 00:58:05 INFO - 'SHELL': '/bin/bash', 00:58:05 INFO - 'SHLVL': '1', 00:58:05 INFO - 'TERM': 'linux', 00:58:05 INFO - 'TMOUT': '86400', 00:58:05 INFO - 'USER': 'cltbld', 00:58:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:05 INFO - '_': '/tools/buildbot/bin/python'} 00:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:05 INFO - Downloading/unpacking psutil>=3.1.1 00:58:05 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 00:58:05 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 00:58:05 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 00:58:05 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 00:58:05 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 00:58:05 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 00:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:58:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:58:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:58:07 INFO - Installing collected packages: psutil 00:58:07 INFO - Running setup.py install for psutil 00:58:07 INFO - building 'psutil._psutil_linux' extension 00:58:07 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 00:58:08 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 00:58:08 INFO - building 'psutil._psutil_posix' extension 00:58:08 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 00:58:09 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 00:58:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:58:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:58:09 INFO - Successfully installed psutil 00:58:09 INFO - Cleaning up... 00:58:09 INFO - Return code: 0 00:58:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:58: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')]} 00:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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')]} 00:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:09 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 0x7f2c2294af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', '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 00:58:09 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 00:58:09 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 00:58:09 INFO - Using env: {'DISPLAY': ':0', 00:58:09 INFO - 'HOME': '/home/cltbld', 00:58:09 INFO - 'LANG': 'en_US.UTF-8', 00:58:09 INFO - 'LANGUAGE': 'en_US:en', 00:58:09 INFO - 'LOGNAME': 'cltbld', 00:58:09 INFO - 'MAIL': '/var/mail/cltbld', 00:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:09 INFO - 'MOZ_NO_REMOTE': '1', 00:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:09 INFO - 'NO_EM_RESTART': '1', 00:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:09 INFO - 'PWD': '/builds/slave/test', 00:58:09 INFO - 'SHELL': '/bin/bash', 00:58:09 INFO - 'SHLVL': '1', 00:58:09 INFO - 'TERM': 'linux', 00:58:09 INFO - 'TMOUT': '86400', 00:58:09 INFO - 'USER': 'cltbld', 00:58:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:09 INFO - '_': '/tools/buildbot/bin/python'} 00:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:58:09 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 00:58:09 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 00:58:09 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 00:58:09 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 00:58:09 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 00:58:09 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 00:58:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:58:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:58:11 INFO - Installing collected packages: mozsystemmonitor 00:58:11 INFO - Running setup.py install for mozsystemmonitor 00:58:11 INFO - Successfully installed mozsystemmonitor 00:58:11 INFO - Cleaning up... 00:58:11 INFO - Return code: 0 00:58:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:11 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 0x7f2c2294af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', '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 00:58:11 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 00:58:11 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 00:58:11 INFO - Using env: {'DISPLAY': ':0', 00:58:11 INFO - 'HOME': '/home/cltbld', 00:58:11 INFO - 'LANG': 'en_US.UTF-8', 00:58:11 INFO - 'LANGUAGE': 'en_US:en', 00:58:11 INFO - 'LOGNAME': 'cltbld', 00:58:11 INFO - 'MAIL': '/var/mail/cltbld', 00:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:11 INFO - 'MOZ_NO_REMOTE': '1', 00:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:11 INFO - 'NO_EM_RESTART': '1', 00:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:11 INFO - 'PWD': '/builds/slave/test', 00:58:11 INFO - 'SHELL': '/bin/bash', 00:58:11 INFO - 'SHLVL': '1', 00:58:11 INFO - 'TERM': 'linux', 00:58:11 INFO - 'TMOUT': '86400', 00:58:11 INFO - 'USER': 'cltbld', 00:58:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:11 INFO - '_': '/tools/buildbot/bin/python'} 00:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:11 INFO - Downloading/unpacking jsonschema==2.5.1 00:58:11 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 00:58:11 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 00:58:11 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 00:58:11 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 00:58:11 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 00:58:11 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 00:58:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:58:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:58:13 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 00:58:13 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 00:58:13 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 00:58:13 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 00:58:13 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 00:58:13 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 00:58:13 INFO - Downloading functools32-3.2.3-2.tar.gz 00:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:58:13 INFO - warning: no files found matching '*.txt' 00:58:13 INFO - no previously-included directories found matching 'build' 00:58:13 INFO - no previously-included directories found matching 'dist' 00:58:13 INFO - no previously-included directories found matching '.git*' 00:58:13 INFO - Installing collected packages: jsonschema, functools32 00:58:14 INFO - Running setup.py install for functools32 00:58:14 INFO - warning: no files found matching '*.txt' 00:58:14 INFO - no previously-included directories found matching 'build' 00:58:14 INFO - no previously-included directories found matching 'dist' 00:58:14 INFO - no previously-included directories found matching '.git*' 00:58:14 INFO - Successfully installed jsonschema functools32 00:58:14 INFO - Cleaning up... 00:58:14 INFO - Return code: 0 00:58:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:58:14 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')]} 00:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:14 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')]} 00:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:14 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 0x7f2c2294af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', '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 00:58:14 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 00:58:14 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 00:58:14 INFO - Using env: {'DISPLAY': ':0', 00:58:14 INFO - 'HOME': '/home/cltbld', 00:58:14 INFO - 'LANG': 'en_US.UTF-8', 00:58:14 INFO - 'LANGUAGE': 'en_US:en', 00:58:14 INFO - 'LOGNAME': 'cltbld', 00:58:14 INFO - 'MAIL': '/var/mail/cltbld', 00:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:14 INFO - 'MOZ_NO_REMOTE': '1', 00:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:14 INFO - 'NO_EM_RESTART': '1', 00:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:14 INFO - 'PWD': '/builds/slave/test', 00:58:14 INFO - 'SHELL': '/bin/bash', 00:58:14 INFO - 'SHLVL': '1', 00:58:14 INFO - 'TERM': 'linux', 00:58:14 INFO - 'TMOUT': '86400', 00:58:14 INFO - 'USER': 'cltbld', 00:58:14 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:14 INFO - '_': '/tools/buildbot/bin/python'} 00:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:58:14 INFO - Cleaning up... 00:58:14 INFO - Return code: 0 00:58:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:58:14 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')]} 00:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:14 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')]} 00:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:14 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 0x7f2c2294af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', '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 00:58:14 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 00:58:14 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 00:58:14 INFO - Using env: {'DISPLAY': ':0', 00:58:14 INFO - 'HOME': '/home/cltbld', 00:58:14 INFO - 'LANG': 'en_US.UTF-8', 00:58:14 INFO - 'LANGUAGE': 'en_US:en', 00:58:14 INFO - 'LOGNAME': 'cltbld', 00:58:14 INFO - 'MAIL': '/var/mail/cltbld', 00:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:14 INFO - 'MOZ_NO_REMOTE': '1', 00:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:14 INFO - 'NO_EM_RESTART': '1', 00:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:14 INFO - 'PWD': '/builds/slave/test', 00:58:14 INFO - 'SHELL': '/bin/bash', 00:58:14 INFO - 'SHLVL': '1', 00:58:14 INFO - 'TERM': 'linux', 00:58:14 INFO - 'TMOUT': '86400', 00:58:14 INFO - 'USER': 'cltbld', 00:58:14 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:14 INFO - '_': '/tools/buildbot/bin/python'} 00:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:14 INFO - Downloading/unpacking blobuploader==1.2.4 00:58:14 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 00:58:14 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 00:58:14 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 00:58:14 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 00:58:14 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 00:58:14 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 00:58:16 INFO - Downloading blobuploader-1.2.4.tar.gz 00:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:58:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:58:16 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 00:58:16 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 00:58:16 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 00:58:16 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 00:58:16 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 00:58:16 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 00:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:58:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:58:17 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 00:58:17 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 00:58:17 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 00:58:17 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 00:58:17 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 00:58:17 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 00:58:17 INFO - Downloading docopt-0.6.1.tar.gz 00:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:58:17 INFO - Installing collected packages: blobuploader, requests, docopt 00:58:17 INFO - Running setup.py install for blobuploader 00:58:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:58:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:58:17 INFO - Running setup.py install for requests 00:58:17 INFO - Running setup.py install for docopt 00:58:17 INFO - Successfully installed blobuploader requests docopt 00:58:17 INFO - Cleaning up... 00:58:17 INFO - Return code: 0 00:58:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:58:17 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')]} 00:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:17 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')]} 00:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:17 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 0x7f2c2294af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', '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 00:58:17 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 00:58:17 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 00:58:17 INFO - Using env: {'DISPLAY': ':0', 00:58:17 INFO - 'HOME': '/home/cltbld', 00:58:17 INFO - 'LANG': 'en_US.UTF-8', 00:58:17 INFO - 'LANGUAGE': 'en_US:en', 00:58:17 INFO - 'LOGNAME': 'cltbld', 00:58:17 INFO - 'MAIL': '/var/mail/cltbld', 00:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:17 INFO - 'MOZ_NO_REMOTE': '1', 00:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:17 INFO - 'NO_EM_RESTART': '1', 00:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:17 INFO - 'PWD': '/builds/slave/test', 00:58:17 INFO - 'SHELL': '/bin/bash', 00:58:17 INFO - 'SHLVL': '1', 00:58:17 INFO - 'TERM': 'linux', 00:58:17 INFO - 'TMOUT': '86400', 00:58:17 INFO - 'USER': 'cltbld', 00:58:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:17 INFO - '_': '/tools/buildbot/bin/python'} 00:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:58:18 INFO - Running setup.py (path:/tmp/pip-0Q_jIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:58:18 INFO - Running setup.py (path:/tmp/pip-x7iDNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:58:18 INFO - Running setup.py (path:/tmp/pip-gotwbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:58:18 INFO - Running setup.py (path:/tmp/pip-Dhu2ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:58:18 INFO - Running setup.py (path:/tmp/pip-UcKVmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:58:18 INFO - Running setup.py (path:/tmp/pip-2FqNTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:58:18 INFO - Running setup.py (path:/tmp/pip-2jVu_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:58:18 INFO - Running setup.py (path:/tmp/pip-bCJTsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:58:18 INFO - Running setup.py (path:/tmp/pip-vlNsFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:58:18 INFO - Running setup.py (path:/tmp/pip-yeNLM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:58:18 INFO - Running setup.py (path:/tmp/pip-Bnq0hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:58:18 INFO - Running setup.py (path:/tmp/pip-gNNQOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:58:18 INFO - Running setup.py (path:/tmp/pip-da_2is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:58:19 INFO - Running setup.py (path:/tmp/pip-lqwbWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:58:19 INFO - Running setup.py (path:/tmp/pip-uH15pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:58:19 INFO - Running setup.py (path:/tmp/pip-XQxswc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:58:19 INFO - Running setup.py (path:/tmp/pip-lzqf2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:58:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:58:19 INFO - Running setup.py install for manifestparser 00:58:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Running setup.py install for mozcrash 00:58:19 INFO - Running setup.py install for mozdebug 00:58:19 INFO - Running setup.py install for mozdevice 00:58:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Running setup.py install for mozfile 00:58:19 INFO - Running setup.py install for mozhttpd 00:58:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Running setup.py install for mozinfo 00:58:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Running setup.py install for mozInstall 00:58:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Running setup.py install for mozleak 00:58:20 INFO - Running setup.py install for mozlog 00:58:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Running setup.py install for moznetwork 00:58:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Running setup.py install for mozprocess 00:58:20 INFO - Running setup.py install for mozprofile 00:58:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Running setup.py install for mozrunner 00:58:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Running setup.py install for mozscreenshot 00:58:20 INFO - Running setup.py install for moztest 00:58:21 INFO - Running setup.py install for mozversion 00:58:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:58:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:58:21 INFO - Cleaning up... 00:58:21 INFO - Return code: 0 00:58:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:21 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 0x7f2c2294af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', '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 00:58:21 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 00:58:21 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 00:58:21 INFO - Using env: {'DISPLAY': ':0', 00:58:21 INFO - 'HOME': '/home/cltbld', 00:58:21 INFO - 'LANG': 'en_US.UTF-8', 00:58:21 INFO - 'LANGUAGE': 'en_US:en', 00:58:21 INFO - 'LOGNAME': 'cltbld', 00:58:21 INFO - 'MAIL': '/var/mail/cltbld', 00:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:21 INFO - 'MOZ_NO_REMOTE': '1', 00:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:21 INFO - 'NO_EM_RESTART': '1', 00:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:21 INFO - 'PWD': '/builds/slave/test', 00:58:21 INFO - 'SHELL': '/bin/bash', 00:58:21 INFO - 'SHLVL': '1', 00:58:21 INFO - 'TERM': 'linux', 00:58:21 INFO - 'TMOUT': '86400', 00:58:21 INFO - 'USER': 'cltbld', 00:58:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:21 INFO - '_': '/tools/buildbot/bin/python'} 00:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:58:21 INFO - Running setup.py (path:/tmp/pip-7L79uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:58:21 INFO - Running setup.py (path:/tmp/pip-KjxMqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:58:21 INFO - Running setup.py (path:/tmp/pip-5LermE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:58:21 INFO - Running setup.py (path:/tmp/pip-vhw9yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:58:21 INFO - Running setup.py (path:/tmp/pip-GoOgP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:58:21 INFO - Running setup.py (path:/tmp/pip-1_GVzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:58:21 INFO - Running setup.py (path:/tmp/pip-9e0d52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:58:21 INFO - Running setup.py (path:/tmp/pip-Kykxk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:58:21 INFO - Running setup.py (path:/tmp/pip-Nj7I_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:58:22 INFO - Running setup.py (path:/tmp/pip-M7YHoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:58:22 INFO - Running setup.py (path:/tmp/pip-yob2ZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:58:22 INFO - Running setup.py (path:/tmp/pip-VKD2wE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:58:22 INFO - Running setup.py (path:/tmp/pip-gTmzG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:58:22 INFO - Running setup.py (path:/tmp/pip-U6fGaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:58:22 INFO - Running setup.py (path:/tmp/pip-hkilBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:58:22 INFO - Running setup.py (path:/tmp/pip-vIDY6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:58:22 INFO - Running setup.py (path:/tmp/pip-_sVhqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:58:22 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)) 00:58:22 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)) 00:58:22 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)) 00:58:22 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)) 00:58:22 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)) 00:58:22 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)) 00:58:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:58:22 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 00:58:22 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 00:58:22 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 00:58:22 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 00:58:22 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 00:58:22 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 00:58:24 INFO - Downloading blessings-1.6.tar.gz 00:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:58:24 INFO - Installing collected packages: blessings 00:58:24 INFO - Running setup.py install for blessings 00:58:24 INFO - Successfully installed blessings 00:58:24 INFO - Cleaning up... 00:58:24 INFO - Return code: 0 00:58:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:58:25 INFO - Reading from file tmpfile_stdout 00:58:25 INFO - Current package versions: 00:58:25 INFO - argparse == 1.2.1 00:58:25 INFO - blessings == 1.6 00:58:25 INFO - blobuploader == 1.2.4 00:58:25 INFO - docopt == 0.6.1 00:58:25 INFO - functools32 == 3.2.3-2 00:58:25 INFO - jsonschema == 2.5.1 00:58:25 INFO - manifestparser == 1.1 00:58:25 INFO - mozInstall == 1.12 00:58:25 INFO - mozcrash == 0.17 00:58:25 INFO - mozdebug == 0.1 00:58:25 INFO - mozdevice == 0.48 00:58:25 INFO - mozfile == 1.2 00:58:25 INFO - mozhttpd == 0.7 00:58:25 INFO - mozinfo == 0.9 00:58:25 INFO - mozleak == 0.1 00:58:25 INFO - mozlog == 3.4 00:58:25 INFO - moznetwork == 0.27 00:58:25 INFO - mozprocess == 0.23 00:58:25 INFO - mozprofile == 0.28 00:58:25 INFO - mozrunner == 6.12 00:58:25 INFO - mozscreenshot == 0.1 00:58:25 INFO - mozsystemmonitor == 0.3 00:58:25 INFO - moztest == 0.7 00:58:25 INFO - mozversion == 1.4 00:58:25 INFO - psutil == 3.1.1 00:58:25 INFO - requests == 1.2.3 00:58:25 INFO - wsgiref == 0.1.2 00:58:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:58: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')]} 00:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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')]} 00:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:25 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 0x7f2c2294af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', '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 00:58:25 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 00:58:25 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 00:58:25 INFO - Using env: {'DISPLAY': ':0', 00:58:25 INFO - 'HOME': '/home/cltbld', 00:58:25 INFO - 'LANG': 'en_US.UTF-8', 00:58:25 INFO - 'LANGUAGE': 'en_US:en', 00:58:25 INFO - 'LOGNAME': 'cltbld', 00:58:25 INFO - 'MAIL': '/var/mail/cltbld', 00:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:25 INFO - 'MOZ_NO_REMOTE': '1', 00:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:25 INFO - 'NO_EM_RESTART': '1', 00:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:25 INFO - 'PWD': '/builds/slave/test', 00:58:25 INFO - 'SHELL': '/bin/bash', 00:58:25 INFO - 'SHLVL': '1', 00:58:25 INFO - 'TERM': 'linux', 00:58:25 INFO - 'TMOUT': '86400', 00:58:25 INFO - 'USER': 'cltbld', 00:58:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:25 INFO - '_': '/tools/buildbot/bin/python'} 00:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:25 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)) 00:58:25 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)) 00:58:25 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)) 00:58:25 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)) 00:58:25 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)) 00:58:25 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)) 00:58:25 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)) 00:58:25 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)) 00:58:25 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)) 00:58:25 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)) 00:58:25 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)) 00:58:25 INFO - Cleaning up... 00:58:25 INFO - Return code: 0 00:58:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:58: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')]} 00:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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')]} 00:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c2294af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', '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 00:58: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', 'jsonschema'] in /builds/slave/test/build 00:58: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 jsonschema 00:58:25 INFO - Using env: {'DISPLAY': ':0', 00:58:25 INFO - 'HOME': '/home/cltbld', 00:58:25 INFO - 'LANG': 'en_US.UTF-8', 00:58:25 INFO - 'LANGUAGE': 'en_US:en', 00:58:25 INFO - 'LOGNAME': 'cltbld', 00:58:25 INFO - 'MAIL': '/var/mail/cltbld', 00:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:25 INFO - 'MOZ_NO_REMOTE': '1', 00:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:25 INFO - 'NO_EM_RESTART': '1', 00:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:25 INFO - 'PWD': '/builds/slave/test', 00:58:25 INFO - 'SHELL': '/bin/bash', 00:58:25 INFO - 'SHLVL': '1', 00:58:25 INFO - 'TERM': 'linux', 00:58:25 INFO - 'TMOUT': '86400', 00:58:25 INFO - 'USER': 'cltbld', 00:58:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:25 INFO - '_': '/tools/buildbot/bin/python'} 00:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:58:25 INFO - Cleaning up... 00:58:25 INFO - Return code: 0 00:58:25 INFO - Running post-action listener: _resource_record_post_action 00:58:25 INFO - Running post-action listener: _start_resource_monitoring 00:58:25 INFO - Starting resource monitoring. 00:58:25 INFO - [mozharness: 2016-10-01 07:58:25.519926Z] Finished create-virtualenv step (success) 00:58:25 INFO - [mozharness: 2016-10-01 07:58:25.520847Z] Running install step. 00:58:25 INFO - Running pre-action listener: _resource_record_pre_action 00:58:25 INFO - Running main action method: install 00:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:58:25 INFO - Reading from file tmpfile_stdout 00:58:25 INFO - Detecting whether we're running mozinstall >=1.0... 00:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:58:25 INFO - Reading from file tmpfile_stdout 00:58:25 INFO - Output received: 00:58:25 INFO - Usage: mozinstall [options] installer 00:58:25 INFO - Options: 00:58:25 INFO - -h, --help show this help message and exit 00:58:25 INFO - -d DEST, --destination=DEST 00:58:25 INFO - Directory to install application into. [default: 00:58:25 INFO - "/builds/slave/test"] 00:58:25 INFO - --app=APP Application being installed. [default: firefox] 00:58:25 INFO - mkdir: /builds/slave/test/build/application 00:58:25 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'] 00:58:25 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 00:58:41 INFO - Reading from file tmpfile_stdout 00:58:41 INFO - Output received: 00:58:41 INFO - /builds/slave/test/build/application/firefox/firefox 00:58:41 INFO - Running post-action listener: _resource_record_post_action 00:58:41 INFO - [mozharness: 2016-10-01 07:58:41.922500Z] Finished install step (success) 00:58:41 INFO - [mozharness: 2016-10-01 07:58:41.922605Z] Running run-tests step. 00:58:41 INFO - Running pre-action listener: _resource_record_pre_action 00:58:41 INFO - Running main action method: run_tests 00:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:58:41 INFO - Python 2.7.3 00:58:41 INFO - Return code: 0 00:58:41 INFO - grabbing minidump binary from tooltool 00:58:41 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')]} 00:58:41 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 0x1145f60>, '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 0x1146d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11471d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:58:41 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 00:58:41 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 00:58:41 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 00:58:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:58:42 INFO - Return code: 0 00:58:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:58:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:58:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:58:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:58:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:58:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 00:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 00:58:42 INFO - Using env: {'DISPLAY': ':0', 00:58:42 INFO - 'HOME': '/home/cltbld', 00:58:42 INFO - 'LANG': 'en_US.UTF-8', 00:58:42 INFO - 'LANGUAGE': 'en_US:en', 00:58:42 INFO - 'LOGNAME': 'cltbld', 00:58:42 INFO - 'MAIL': '/var/mail/cltbld', 00:58:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:58:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:42 INFO - 'MOZ_NO_REMOTE': '1', 00:58:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:58:42 INFO - 'NO_EM_RESTART': '1', 00:58:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:42 INFO - 'PWD': '/builds/slave/test', 00:58:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:58:42 INFO - 'SHELL': '/bin/bash', 00:58:42 INFO - 'SHLVL': '1', 00:58:42 INFO - 'TERM': 'linux', 00:58:42 INFO - 'TMOUT': '86400', 00:58:42 INFO - 'USER': 'cltbld', 00:58:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283', 00:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:42 INFO - '_': '/tools/buildbot/bin/python'} 00:58:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 00:58:42 INFO - mozversion application_buildid: 20160930232556 00:58:42 INFO - mozversion application_changeset: fcc62bbf09eecabf27c8d198d5d3719e16b296ea 00:58:42 INFO - mozversion application_display_name: Nightly 00:58:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:58:42 INFO - mozversion application_name: Firefox 00:58:42 INFO - mozversion application_remotingname: firefox 00:58:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:58:42 INFO - mozversion application_vendor: Mozilla 00:58:42 INFO - mozversion application_version: 52.0a1 00:58:42 INFO - mozversion platform_buildid: 20160930232556 00:58:42 INFO - mozversion platform_changeset: fcc62bbf09eecabf27c8d198d5d3719e16b296ea 00:58:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:58:42 INFO - mozversion platform_version: 52.0a1 00:58:42 INFO - using testdate: 1475308722 00:58:42 INFO - actual date: 1475308722 00:58:42 INFO - starting webserver on 'localhost:50604' 00:58:42 INFO - SUITE-START | Running 2 tests 00:58:42 INFO - TEST-START | dromaeo_css 00:58:42 INFO - operating with platform_type : linux_ 00:58:42 INFO - Initialising browser for dromaeo_css test... 00:58:42 INFO - TEST-INFO | started process 3306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4rn3Yy/profile http://localhost:50604/getInfo.html) 00:58:49 INFO - PROCESS | 3306 | __metrics Screen width/height:1600/1200 00:58:49 INFO - PROCESS | 3306 | colorDepth:24 00:58:49 INFO - PROCESS | 3306 | Browser inner width/height: 1024/697 00:58:49 INFO - PROCESS | 3306 | __metrics 00:58:49 INFO - PROCESS | 3306 | 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" 00:58:49 INFO - PROCESS | 3306 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:58:50 INFO - PROCESS | 3306 | console.error: PushService: 00:58:50 INFO - PROCESS | 3306 | stateChangeProcessEnqueue: Error transitioning state 00:58:50 INFO - PROCESS | 3306 | UnknownError 00:58:51 INFO - TEST-INFO | 3306: exit 0 00:58:51 INFO - Browser initialized. 00:58:51 INFO - Running cycle 1/1 for dromaeo_css test... 00:58:51 INFO - TEST-INFO | started process 3389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4rn3Yy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:59:03 INFO - PROCESS | 3389 | RSS: Main: 175493120 00:59:03 INFO - PROCESS | 3389 | 00:59:54 INFO - PROCESS | 3389 | 1475308794798 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] 01:02:08 INFO - PROCESS | 3389 | Cycle 1(1): loaded http://localhost:50604/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50604/tests/dromaeo/cssquery-ext.html) 01:02:10 INFO - PROCESS | 3389 | RSS: Main: 305930240 01:02:10 INFO - PROCESS | 3389 | 01:05:13 INFO - PROCESS | 3389 | Cycle 1(1): loaded http://localhost:50604/tests/dromaeo/cssquery-ext.html (next: http://localhost:50604/tests/dromaeo/cssquery-jquery.html) 01:05:13 INFO - PROCESS | 3389 | RSS: Main: 269840384 01:05:13 INFO - PROCESS | 3389 | 01:08:15 INFO - PROCESS | 3389 | Cycle 1(1): loaded http://localhost:50604/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50604/tests/dromaeo/cssquery-mootools.html) 01:08:16 INFO - PROCESS | 3389 | RSS: Main: 220024832 01:08:16 INFO - PROCESS | 3389 | 01:11:18 INFO - PROCESS | 3389 | Cycle 1(1): loaded http://localhost:50604/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50604/tests/dromaeo/cssquery-prototype.html) 01:11:19 INFO - PROCESS | 3389 | RSS: Main: 220176384 01:11:19 INFO - PROCESS | 3389 | 01:14:22 INFO - PROCESS | 3389 | Cycle 1(1): loaded http://localhost:50604/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50604/tests/dromaeo/cssquery-yui.html) 01:14:22 INFO - PROCESS | 3389 | RSS: Main: 221855744 01:14:22 INFO - PROCESS | 3389 | 01:17:25 INFO - PROCESS | 3389 | Cycle 1(1): loaded http://localhost:50604/tests/dromaeo/cssquery-yui.html (next: http://localhost:50604/tests/dromaeo/cssquery-dojo.html) 01:17:26 INFO - PROCESS | 3389 | RSS: Main: 310255616 01:17:26 INFO - PROCESS | 3389 | 01:17:26 INFO - PROCESS | 3389 | __start_tp_report 01:17:26 INFO - PROCESS | 3389 | _x_x_mozilla_page_load 01:17:26 INFO - PROCESS | 3389 | _x_x_mozilla_page_load_details 01:17:26 INFO - PROCESS | 3389 | |i|pagename|runs| 01:17:26 INFO - PROCESS | 3389 | |0;dojo.html;2548.75786800254;2582.4576838863836;2609.7520735530125;2619.5415802234616;2632.0129951268273;4504.504504504502;4559.247724125524;4679.649026323026;4695.788689508971;4708.317293992373;4568.908621827562;4588.7476188809605;4594.931076033862;4601.585857272845;4603.4706008809;4224;4249.3413520904305;4253.3619957006385;4276.25165596021;4309.26742453782;4327.5888790565;4330.84842030529;4351.738895666254;4361.60745532902;4395;4325.675574331922;4334.696571240014;4384.4519435070615;4387.341898715203;4433.578810013044;4248.745075295492;4340.739555626641;4368.388425620416;4375.2124617568825;4378;4296.462942132233;4307.741535507879;4343.413639158736;4369.344598310247;4389.890252743675;4504.256797628387;4539.863804085882;4550.203714350008;4605.700629459075;4632.675712700112;4872.123017856784;4907.386576677915;4931.284963680282;4979.825706100269;4980.676256043345;4898.02039592083;4927.285543596195;4927.384076990376;4929.433115191763;4942.283368911523;4640.9535904640525;4643.95356046442;4644.674872758942;4689.39037925071;4705.976470117696;4921.876953076202;4975.651704380659;5059.822906198266;5090.134677104901;5117.104506711311;4844.975775121102;4911.3369695090705;4911.386076740408;4913.9017219656125;4968.552830245295;4951.950480495221;4954.40547134339;4958.206686930074;4962.280469331927;4982.501749824988;4750.809967601326;4771.06964141989;4833.3958255218095;4877.3903262092235;4955.702657840541;4890.119778439844;4903.043906438282;4914.803407863646;4917.827876024322;4955.108080545464;4231.301835197158;4240.1307731914885;4241.406203131564;4280.443542339476;4291.0559676871035;3638.581563120275;3667.74325797197;3687.9815600921825;3689.870854520079;3753.042974041602;4166.729162604421;4210.852620158341;4216.494020717533;4241.130568233505;4260.595243451867;4878.731669758197;4878.756062196876;4884.0476107159475;4932.26016097581;4938.037082768898;4231.513375961804;4231.640310573574;4236.046889449849;4237.322028475429;4282.272013757669;4402.097569998143;4404.317330813729;4461.776911154429;4463.977680111579;4512.706674066241;4607.7004994675235;4661.254199328091;4662.370579971661;4664.463586687574;4664.79008444614;4908.705477671351;4971.527704868032;4982.327385803015;4983.352164218629;4983.426905905722;4593.425821772278;4631.907361852676;4654.348391225299;4661.230896901973;4683.601893839062;4926.3842019747535;4936.407631084293;4937.086638971802;4997.350344455343;5000.149974504416;4983.925241121458;4992.226204938241;4994.850154495371;4998.825041123543;5059.038782631288;4697.553732395417;4729.574338309569;4863.610911127031;4876.512348765095;4932.926006109983;4750;4786.875084355104;4822.9758851205515;4833.3958255218095;4891.144049791201;4740.146773580788;4744.4069491313585;4749.26386410107;4754.809807607657;4806.7836947338155;4747.8575642730775;4857.368542089505;4858.854234372974;4867.9269810952155;4932.679375840559;4691.202495575829;4715.976420117878;4753.738544379954;4759.738214398241;4761.833335833229 01:17:26 INFO - PROCESS | 3389 | |1;ext.html;559.2282649943079;568.91466280058;574.1559906936801;577.1112486770373;585.7364186116249;27817.582736258948;38363.42454863176;39898.80050599747;39974;43766.7811660942;39864;40245.39631905524;40309.59690403095;40313.7984310078;40328.59671403285;7612.58130802807;7798.2981531662135;7800.804979875492;7803.765887023398;7806.5316081035035;7650.043744531934;7734.342580880604;7734.690612375498;7736.1877002914725;7736.690532378698;7731.265529774662;7761.805954851117;7777.688892444296;7777.766666999971;7789.337906277973;7697.692092316301;7749.651265693057;7758.534487930742;7761.379089672812;7761.45669803114;7611.3149816516225;7685.385169186452;7685.923140768577;7685.961570192169;7687.615619219073;38114.42828357577;38303;38424.231515369815;38510;38520;2679.249810053169;2816.2959260184953;2980.3741214345014;2983.5518332697625;3397.252604427022;28338.14985550437;28556.571651425245;28976.565351519745;29315.853420732972;29907.25231869199;3120.60992375953;3222.0179485527597;3350.3466823969093;3433.1931995980926;3479.7216222702123;200898;201952;205143;259092.704536478;260573;56409;57134.714326428104;57179.71410143006;57195.42804571984;57295.42704572984;33786.32427351488;34265;34338.656613433544;36229.45655815165;36252;13096.14875033139;13296.734065318833;13299.734005320033;13310.267935263653;13320.200787952754;9909.900900991042;10023.649172278936;10033.046860548237;10038.44788536623;10039.548220330104;18625.906870465562;18714.064296785105;18716.906415467834;18785.90607046956;18802.905985469984;7082.716691332392;7152.964235178791;7278.272172782679;7295.708171673074;7452.739154129579;771.9845603087907;845.678642115992;898.5821592959174;916.3860213656866;935.5228833295068;26711.866440667673;27146.185614431597;27451;27692;28159.43681126366;903.8644203369415;908.1100521488978;916.4959272400154;919.9696340099132;964.8552717092352;14620.926895365668;15021.774673379909;15030.699386012218;15038;15095.924520377328;365705;366578;370237;372244;372686;47777.522224778004;47809.76095119502;47921;48118.27822582664;48317.275240871415;1031.7884833609091;1061.2040969273046;1067.3115840283128;1161.7734541764444;1180.167981572989;21264.681029784875;28714;28740.712592873802;31342.216444588157;31941.722331106495;46701.53298466972;47259.76370118265;47280.290795637404;47296;47373;324699.9065098225;325188;326480;326857;328160;22203.1118755248;22780.886095569414;24844.751552484966;25667.3583160415;26081.347966300993;38004.809975949946;40072;40245.79877100596;40577.79711101425;41844.3723344144;35189.472157918164;35212;35269.64730352664;35287.82356088203;36031.31592892907;35222.11944701403;35404.64595354014;35820.28359432745;35987.280254394245;36022.4596631056;29717.85141074367;30161.698383016766;33513.72245844631;34218.82890585531;34620.480692789126;30802.537961930142;32259.677403226608;32517.34965300728;32580;32713.836430817693;24916.75083249217;24963.875180624706;25045.373865653506;25172.74827251704;25587.6161857576 01:17:26 INFO - PROCESS | 3389 | |2;jquery.html;346.0242117229414;360.2506785885359;360.82860641195435;369.06810303982445;382.44354464254513;12242.143049986504;12658;16006;16240.350385984577;16910.492685219433;15076.6984660307;15256.771148432783;15354.46259380919;17005.064721440314;17097.743533847002;4037.838486460538;4898.24077268024;5130.974345128269;5138.100832354342;5141.948580514184;5799.826005219829;5948.315943666469;6001.759929602811;6009.06859436788;6012.338642749294;5153.896922061556;5431.592630552705;5993.041113421853;5996.550258730591;6002.609830361034;5493.23094766733;5525.336959564837;5526.447355264441;5535.972320138414;5537.446255374471;5213.400458947193;5328.280682107905;5370.462953704638;5382.058139825514;5392.325959255093;11842;11891.583794567148;11998.760024799543;12017.158798884082;12500.187487813353;1724.6292047209786;1804.106967051305;1812.247917114396;1812.4019073705645;1832.5235438786012;8542.316614670874;9074.818503629891;9116.498592577405;9431.481268530297;9592.08875156859;1709.350446830209;1720.698877696398;1741.7126174181244;1809.8280663336961;1820.8816426932208;65648.3435165647;65680;67973.3202667972;68685.31314686839;68865;9325.813483730288;9480.762980925394;9865.704028879145;9879.16027137687;10096.444695541815;13306.600801975956;13560.321983900765;13580.45678172862;13731;13756.380962856496;6715.429188518933;6893.620850853151;6900.137482814648;7015.333543313377;7027.1701922452385;6367.713452894631;6403.48772098231;6515.576487528296;6593.571417857824;6608.107905432801;4174.937375939303;4225.72532785368;4237.512686041083;4368.8907777305185;4377.0808130293;1761.330694336144;1881.1346780481133;1893.0028819595184;1908.5133291010704;1913.1295260656368;733.9559626422432;831.5966756123275;833.083608031173;867.6399294292797;927.2581934452411;16047.759283610756;17371.218295176746;17387.826121738875;17658.293668253125;17758.46724598264;796.3828033274259;798.4769975665948;853.389826274217;882.748416701237;889.1197714262834;9236.214921731593;9438.339316247797;9744.415335079777;9784.608615655436;9830.705078847646;344675;356385;356897;356998;357330;73930;74549;75796;77234.61382693051;79271;846.7967687755017;864.2653744317406;869.3783944479601;890.1410139215687;890.6660002499062;14625.34185961613;15035.323410446337;15298.61753456128;15414.152221627917;15613.297401616728;34639.30721385508;35784.821075894455;36750.8162459186;36765.63234367622;36985.26029479449;47006.529934700215;47217;48005.27992080191;48128.27807582959;55865.72067139638;6484.416402523795;6744.966275168593;7074.398676112588;7105.18290396611;7369.963150184215;8984.86522702147;11066.833997489883;11824.527018919147;12430.502779889064;12644.810327845275;9448.811023779623;9509.239260859253;9713.222942164752;9790.608375665179;10043;10253.231007674603;10314.793704125725;10404.479776011018;10801.621943231949;10894.182936279652;9799.85300220483;9885.654002109892;9935.751606209902;9980.900190998287;10322.174226062047;7095.270815283944;7156.534825236343;7436.776896693108;7492.063492063492;7518.135414427411;8608.311335093304;9123.635054597742;9423.246140308622;9641.11255109156;9704.369216000938 01:17:26 INFO - PROCESS | 3389 | |3;mootools.html;1236.5177580743507;1328.574856046065;1391.5616580777055;1446.443119399031;1656.9834301656988;6706.66466676666;7323.560586364815;7505.099388073439;7713.6914523419;7715.807104822382;7719.112302085262;7779.844403111949;7783.338416234613;7791.493552919056;7798.454108212427;2130.2650585547963;2175.8476906616465;2176.880271585062;2187.267265466071;2193.8683678979314;2097.528056187361;2142.6678864775986;2171.109844963565;2171.392010237128;2185.650295952648;2114.619368513667;2116.608427440921;2121.586290673319;2127.2235633993637;2190.0582749417745;2106.683997400387;2112.2501511963187;2112.7675955644945;2114.12263910477;2117.14255726431;2017.2334512885157;2079.1579410338686;2083.4895450614545;2090.34154241415;2094.6857971304426;7707.768766937001;7799.298063174285;7834.255745704149;7868.173841746591;7876.488028278143;4261.659067274611;4413.249747542925;4432.401625780511;4447.888802779924;4457.309117086825;2880.35192081782;3048.84755762211;3077.9538306925415;3099.0857696979447;3112.5331200319906;838.6771093129129;847.2840449819893;853.3898262742107;876.5222953490363;884.752269364579;10443.216758743049;10453.581856725721;10463.05832475081;10524.315919465287;10544.683659490227;3708.981455092707;3945.5265368156006;4015.257177422186;4064.1262128642484;4076.510818701775;8249.752507424786;8250.298724608356;8251.95874020626;8253.298469630148;8253.79365515867;4320.611144996966;4322.286822674287;4323.221820072355;4325.98339390243;4326.675499337499;3521.190126270972;3626.437902125175;3866.516685414323;3953.7034722395933;3981.641652251253;3247.2531317796565;3340.799552026838;3392.9830350848088;3409.846556904896;3413.061408112739;999.7200783780553;1015.761296095417;1017.9032991865761;1018.8573599696049;1025.179856115105;737.1228238396292;768.7655265144073;770.2105342024357;778.4978688745728;799.8040480082301;4758.571728544448;4849.781759820817;4930.411533944708;4990.4011518618;5086.516780905808;789.9723509677134;793.9682412703543;799.3525244551931;816.7508909782455;823.9876401853977;3113.8598763055716;3196.1370429983776;3299.488579270217;3320.7177389922126;3375.5105509700957;9469.857952130724;9890.703278901645;9913.75215619601;9926;9936.105750482491;9829.066238707312;9838.458884761407;9839.754006149904;9844.261680373857;9849.45827979468;7230.42156627479;7231.710731570678;7246.970848162523;7356.301151390609;7409.88885166723;4616.930746038879;4701.059788042337;4740.19416699155;4785.258284965836;4857.708537487762;8960.103989600988;9021.458712477272;9029.954850225708;9044.592993315186;9114.908850911406;8397.70608028716;8821.073787252502;8852.24755895756;9073.954630226806;9161.954190229006;5947.750972295867;6535.379138981979;6704.83237919056;6705.396514313735;6727.529072964846;6618.404343609098;6816.250212476524;6825.55633883796;6828.5902845829405;6829.146356705412;5794;5819;5989.3711160329285;6210.285817130907;6325.146105275913;6087.634741915499;6163.599366041193;6188.381161883775;6225.968870155621;6233.0338797486465;5664.178694089252;5682.744276507485;5748.396418376177;5748.913766293593;5751.424857514383;4234.386014027887;4249.575042495726;4260.147970405869;4325.653947684114;4342.652587793033;4176.582341765799;4277.1873344064525;4318.071614602875;4319.503257125345;4340.197063543254 01:17:26 INFO - PROCESS | 3389 | |4;prototype.html;284.5674574646537;289.59601356108226;294.92646765772594;301.38968588608077;303.6037970448564;4775.832845850396;4778.832740854071;4802.95197048029;4812.807487700487;4818.494058123894;4704.952950470502;4705.17689386368;4741.834035808747;4756.381670382854;4765.166095933215;3731.235096805162;3745.719071069667;3750.1187221003042;3762.4168253920548;3771.283456143324;3681.11653203232;3774.5470543534816;3775.490308808317;3817.7136714746366;3818.3890577507605;3684.926301473969;3736.1967177056927;3740.438934159884;3744.988853009686;3752.924941501168;3700.7594506357;3718.4236443351324;3720;3721.218544105741;3731.1977924746175;3057;3154.41643295991;3300.1914530939835;3302.339532093591;3314.585676790401;4481.6638752093395;4623.69945953512;4642.210824159901;4661.067786442691;4661.650376221763;4248.362745588156;4253.553376895412;4261.339492378686;4272.145570885804;4272.252355837716;4859.860768374106;4915.5330243626795;4976.178930476467;4985.501449855022;4996.825111121129;3598.5681718193982;3602.225521512887;3603.855845766166;3608.657177568127;3612.259486805199;5139.383274007106;5152.252923326097;5157.530103920402;5183.663061900965;5195.5324020837925;3689.5241903238384;3697.242065376591;3712.3132220539287;3716.3867961786004;3732.496113024707;3669.4679271506016;3721.218544105768;3736.7010639148803;3742.1393079591303;3780.3762379207674;4184.832606695698;4204.180184863983;4217.093324935154;4238.87283381499;4241.618254357123;4939.580135688435;4966.1061009018;4985.451600323961;4996.90006199874;5042.268871013683;1255.253124390986;1262.6780171056505;1289.6775806048488;1293.9260413856477;1294.1911305434103;824.9216324449168;840.1682334488934;841.9013187789993;851.4805968359295;852.5822347050025;3999.7600143991453;4003.5796241394232;4004.3582131326016;4041.5958404159937;4057.634812866856;4575.199340115467;4598.97700511502;4608.907821843544;4652.395188625457;4665.440147182292;3881.223755248905;3942.4086387042175;4039.8788036358956;4056.9188616228103;4061.5532291447917;2436.1229957215387;2456.7666071723156;2458.4591389894554;2461.2124120281337;2478.8388754730886;4308.6983911126545;4575.565321294472;4709.634206080267;4741.454732705783;4795.904081918412;5244.239585260192;5245.554127899171;5270.841874743764;5285.709285989307;5310.707911064928;4851.417829860439;4861.149298872754;4875.975620121948;4879.243717223836;4882.145624515767;5034.546890779848;5136.460671629575;5165.225216217597;5175.378954525481;5187.377514698261;5080.542751152414;5082.263071854634;5085.949140508547;5111.3355263815465;5115.846524604268;4855.611551075976;4862.513748625109;4862.805487780449;4876.683015603974;4887.657863949632;3410.505476705814;3578.3916734154736;3639.908027591659;3640.0535860675886;3641.8361173747776;5157.484251574962;5170.6380553360905;5170.819021334235;5178;5192.896142077062;5012.097822392005;5019.472955339783;5029.1953287473825;5056.772445240046;5056.811649262347;4881.951180488291;4904.632152588499;4962.3052772611145;4974.204127339608;4980.377452818398;4898.681585696918;4909.257213689231;4910.796854770461;4911.214205727067;4914.70511769295;5029.396472423186;5053.494650534917;5084.694918304914;5090.440051594248;5103.974480127576;4756.7145971241835;4897.755112244302;4914.729689867092;4927.802887884444;4932.580730637936 01:17:26 INFO - PROCESS | 3389 | |5;yui.html;577.0593931891019;577.4254616656427;580.4688709830504;581.9272590926134;588.4380416702048;10562.735931601695;10817.134629229662;11454.02640775534;11492.310461372323;11924.701882452942;11543.076553875691;11907.880921190806;11918.28490290581;11942.402879856016;11990.7601847963;721.019413597507;721.0266140710052;721.2462976189894;724.8586525627492;727.2618292433184;616.6762449713891;617.5090802811775;626.0171530696808;638.0620487882804;770.4337312075648;667.9031540426636;780.5355813291083;782.2138750555683;787.629813987425;817.9222973817508;773.6827900560743;774.9263819937097;775.8293175501381;775.8370742144157;778.9766307010799;562.0304973919955;562.6202313438413;564.4045531963776;565.547561950438;566.5637459156468;8612.095729948327;8925.330600204945;10484.528196231187;10910.563577456893;10946.343219406781;11514.424278786028;11658.300501969909;11773.470193841298;11913.285202887855;12875.67810804728;10338;10373.222008349328;10392.740181495448;10509.31689440184;10612.840807387895;3300.2574420755377;3301.933961320784;3306.437905556061;3390.847411866472;3397.048826328632;50224;52063.21905171463;52221;65237.99999999953;65517.86196346633;9387.29595280343;9697.757556061155;10027.448490332956;10034.197264218845;10285.897141028643;17079.231434585472;17210.39763608268;17393.217305221297;17438.82561174372;17486.737698934525;6427.132337134521;6475.838104047437;6523.7716679915975;6587.604743715392;6856.177258728984;3542.6457354264367;3587.0494319005484;3595.3168897909313;3602.2615363850346;3646.4530320452145;2741.1091395296608;2817.4365126974685;2823.3365159187574;2832.1361984594896;2841.962683620464;510.83908568800706;511.66741617948634;513.5480776916289;515.9484051594885;526.3920172201114;501.79175642108845;530.7770736290768;544.257089073412;551.48987186852;555.7832445346318;7761.844763104819;7890.8816367754525;7948.682052717826;7967.922124911418;8016.438849280611;478.9233722604367;542.2544001997254;544.2353493341861;546.8359492152339;561.1498579651831;3580.2481478889727;3691.0034290741887;3830.157365379612;3845.2309538091936;3957.231422337201;78492;103208.48395757974;104602;105573;108580;87372;89901.55049224712;90232.5488372567;90330.54834725785;90915.54542227379;59321;77691.2230877684;78674;79009.20990790133;80296.19703803003;7470.551766894004;7614.923850761422;7680.155182929761;7746.186650401627;7785.805354866174;44209;44925.77537112294;46786.532134678215;47043;47212.527874720814;60496;65511.672441637485;65642;65681;65694;9053.230475409664;9610.675443901253;9711.320207585684;9776.80446391054;9810.411375317504;10751.301165424222;10841.18691098155;10865.239433239598;11037.227394082338;11106.722331941766;10135.949320253647;10215.233857460571;10218.897811021794;10312.639057632947;10577.894221057999;9046.54767261621;9062.184403403726;9114.179723824887;9358.672446464341;9460.385074970105;9827.557759900965;10417.583296668352;10782.1913356497;10954.671359859218;11196.328220306481;8133.877991830009;8174.427790054639;8419.284360829399;8448.535330556879;8562.400631955703;8505.659773608986;8560.828783424422;8795.428297160664;8972.926600562429;9053.139951704577 01:17:26 INFO - PROCESS | 3389 | __end_tp_report 01:17:26 INFO - PROCESS | 3389 | __start_cc_report 01:17:26 INFO - PROCESS | 3389 | _x_x_mozilla_cycle_collect,1148 01:17:26 INFO - PROCESS | 3389 | __end_cc_report 01:17:26 INFO - PROCESS | 3389 | __startTimestamp1475309846076__endTimestamp 01:17:26 INFO - PROCESS | 3389 | 01:17:26 INFO - PROCESS | 3389 | ------- Summary: start ------- 01:17:26 INFO - PROCESS | 3389 | Number of tests: 6 01:17:26 INFO - PROCESS | 3389 | 01:17:26 INFO - PROCESS | 3389 | [#0] dojo.html Cycles:165 Average:4582.23 Median:4691.20 stddev:467.86 (10.0%) stddev-sans-first:441.26 01:17:26 INFO - PROCESS | 3389 | Values: 2548.8 2582.5 2609.8 2619.5 2632.0 4504.5 4559.2 4679.6 4695.8 4708.3 4568.9 4588.7 4594.9 4601.6 4603.5 4224.0 4249.3 4253.4 4276.3 4309.3 4327.6 4330.8 4351.7 4361.6 4395.0 4325.7 4334.7 4384.5 4387.3 4433.6 4248.7 4340.7 4368.4 4375.2 4378.0 4296.5 4307.7 4343.4 4369.3 4389.9 4504.3 4539.9 4550.2 4605.7 4632.7 4872.1 4907.4 4931.3 4979.8 4980.7 4898.0 4927.3 4927.4 4929.4 4942.3 4641.0 4644.0 4644.7 4689.4 4706.0 4921.9 4975.7 5059.8 5090.1 5117.1 4845.0 4911.3 4911.4 4913.9 4968.6 4952.0 4954.4 4958.2 4962.3 4982.5 4750.8 4771.1 4833.4 4877.4 4955.7 4890.1 4903.0 4914.8 4917.8 4955.1 4231.3 4240.1 4241.4 4280.4 4291.1 3638.6 3667.7 3688.0 3689.9 3753.0 4166.7 4210.9 4216.5 4241.1 4260.6 4878.7 4878.8 4884.0 4932.3 4938.0 4231.5 4231.6 4236.0 4237.3 4282.3 4402.1 4404.3 4461.8 4464.0 4512.7 4607.7 4661.3 4662.4 4664.5 4664.8 4908.7 4971.5 4982.3 4983.4 4983.4 4593.4 4631.9 4654.3 4661.2 4683.6 4926.4 4936.4 4937.1 4997.4 5000.1 4983.9 4992.2 4994.9 4998.8 5059.0 4697.6 4729.6 4863.6 4876.5 4932.9 4750.0 4786.9 4823.0 4833.4 4891.1 4740.1 4744.4 4749.3 4754.8 4806.8 4747.9 4857.4 4858.9 4867.9 4932.7 4691.2 4716.0 4753.7 4759.7 4761.8 01:17:26 INFO - PROCESS | 3389 | 01:17:26 INFO - PROCESS | 3389 | [#1] ext.html Cycles:180 Average:45773.55 Median:36004.87 stddev:82536.71 (229.2%) stddev-sans-first:82698.43 01:17:26 INFO - PROCESS | 3389 | Values: 559.2 568.9 574.2 577.1 585.7 27817.6 38363.4 39898.8 39974.0 43766.8 39864.0 40245.4 40309.6 40313.8 40328.6 7612.6 7798.3 7800.8 7803.8 7806.5 7650.0 7734.3 7734.7 7736.2 7736.7 7731.3 7761.8 7777.7 7777.8 7789.3 7697.7 7749.7 7758.5 7761.4 7761.5 7611.3 7685.4 7685.9 7686.0 7687.6 38114.4 38303.0 38424.2 38510.0 38520.0 2679.2 2816.3 2980.4 2983.6 3397.3 28338.1 28556.6 28976.6 29315.9 29907.3 3120.6 3222.0 3350.3 3433.2 3479.7 200898.0 201952.0 205143.0 259092.7 260573.0 56409.0 57134.7 57179.7 57195.4 57295.4 33786.3 34265.0 34338.7 36229.5 36252.0 13096.1 13296.7 13299.7 13310.3 13320.2 9909.9 10023.6 10033.0 10038.4 10039.5 18625.9 18714.1 18716.9 18785.9 18802.9 7082.7 7153.0 7278.3 7295.7 7452.7 772.0 845.7 898.6 916.4 935.5 26711.9 27146.2 27451.0 27692.0 28159.4 903.9 908.1 916.5 920.0 964.9 14620.9 15021.8 15030.7 15038.0 15095.9 365705.0 366578.0 370237.0 372244.0 372686.0 47777.5 47809.8 47921.0 48118.3 48317.3 1031.8 1061.2 1067.3 1161.8 1180.2 21264.7 28714.0 28740.7 31342.2 31941.7 46701.5 47259.8 47280.3 47296.0 47373.0 324699.9 325188.0 326480.0 326857.0 328160.0 22203.1 22780.9 24844.8 25667.4 26081.3 38004.8 40072.0 40245.8 40577.8 41844.4 35189.5 35212.0 35269.6 35287.8 36031.3 35222.1 35404.6 35820.3 35987.3 36022.5 29717.9 30161.7 33513.7 34218.8 34620.5 30802.5 32259.7 32517.3 32580.0 32713.8 24916.8 24963.9 25045.4 25172.7 25587.6 01:17:26 INFO - PROCESS | 3389 | 01:17:26 INFO - PROCESS | 3389 | [#2] jquery.html Cycles:180 Average:22760.78 Median:5387.19 stddev:58760.43 (1090.7%) stddev-sans-first:58901.17 01:17:26 INFO - PROCESS | 3389 | Values: 346.0 360.3 360.8 369.1 382.4 12242.1 12658.0 16006.0 16240.4 16910.5 15076.7 15256.8 15354.5 17005.1 17097.7 4037.8 4898.2 5131.0 5138.1 5141.9 5799.8 5948.3 6001.8 6009.1 6012.3 5153.9 5431.6 5993.0 5996.6 6002.6 5493.2 5525.3 5526.4 5536.0 5537.4 5213.4 5328.3 5370.5 5382.1 5392.3 11842.0 11891.6 11998.8 12017.2 12500.2 1724.6 1804.1 1812.2 1812.4 1832.5 8542.3 9074.8 9116.5 9431.5 9592.1 1709.4 1720.7 1741.7 1809.8 1820.9 65648.3 65680.0 67973.3 68685.3 68865.0 9325.8 9480.8 9865.7 9879.2 10096.4 13306.6 13560.3 13580.5 13731.0 13756.4 6715.4 6893.6 6900.1 7015.3 7027.2 6367.7 6403.5 6515.6 6593.6 6608.1 4174.9 4225.7 4237.5 4368.9 4377.1 1761.3 1881.1 1893.0 1908.5 1913.1 734.0 831.6 833.1 867.6 927.3 16047.8 17371.2 17387.8 17658.3 17758.5 796.4 798.5 853.4 882.7 889.1 9236.2 9438.3 9744.4 9784.6 9830.7 344675.0 356385.0 356897.0 356998.0 357330.0 73930.0 74549.0 75796.0 77234.6 79271.0 846.8 864.3 869.4 890.1 890.7 14625.3 15035.3 15298.6 15414.2 15613.3 34639.3 35784.8 36750.8 36765.6 36985.3 47006.5 47217.0 48005.3 48128.3 55865.7 6484.4 6745.0 7074.4 7105.2 7370.0 8984.9 11066.8 11824.5 12430.5 12644.8 9448.8 9509.2 9713.2 9790.6 10043.0 10253.2 10314.8 10404.5 10801.6 10894.2 9799.9 9885.7 9935.8 9980.9 10322.2 7095.3 7156.5 7436.8 7492.1 7518.1 8608.3 9123.6 9423.2 9641.1 9704.4 01:17:26 INFO - PROCESS | 3389 | 01:17:26 INFO - PROCESS | 3389 | [#3] mootools.html Cycles:180 Average:4936.11 Median:4894.06 stddev:2849.26 (58.2%) stddev-sans-first:2843.69 01:17:26 INFO - PROCESS | 3389 | Values: 1236.5 1328.6 1391.6 1446.4 1657.0 6706.7 7323.6 7505.1 7713.7 7715.8 7719.1 7779.8 7783.3 7791.5 7798.5 2130.3 2175.8 2176.9 2187.3 2193.9 2097.5 2142.7 2171.1 2171.4 2185.7 2114.6 2116.6 2121.6 2127.2 2190.1 2106.7 2112.3 2112.8 2114.1 2117.1 2017.2 2079.2 2083.5 2090.3 2094.7 7707.8 7799.3 7834.3 7868.2 7876.5 4261.7 4413.2 4432.4 4447.9 4457.3 2880.4 3048.8 3078.0 3099.1 3112.5 838.7 847.3 853.4 876.5 884.8 10443.2 10453.6 10463.1 10524.3 10544.7 3709.0 3945.5 4015.3 4064.1 4076.5 8249.8 8250.3 8252.0 8253.3 8253.8 4320.6 4322.3 4323.2 4326.0 4326.7 3521.2 3626.4 3866.5 3953.7 3981.6 3247.3 3340.8 3393.0 3409.8 3413.1 999.7 1015.8 1017.9 1018.9 1025.2 737.1 768.8 770.2 778.5 799.8 4758.6 4849.8 4930.4 4990.4 5086.5 790.0 794.0 799.4 816.8 824.0 3113.9 3196.1 3299.5 3320.7 3375.5 9469.9 9890.7 9913.8 9926.0 9936.1 9829.1 9838.5 9839.8 9844.3 9849.5 7230.4 7231.7 7247.0 7356.3 7409.9 4616.9 4701.1 4740.2 4785.3 4857.7 8960.1 9021.5 9030.0 9044.6 9114.9 8397.7 8821.1 8852.2 9074.0 9162.0 5947.8 6535.4 6704.8 6705.4 6727.5 6618.4 6816.3 6825.6 6828.6 6829.1 5794.0 5819.0 5989.4 6210.3 6325.1 6087.6 6163.6 6188.4 6226.0 6233.0 5664.2 5682.7 5748.4 5748.9 5751.4 4234.4 4249.6 4260.1 4325.7 4342.7 4176.6 4277.2 4318.1 4319.5 4340.2 01:17:26 INFO - PROCESS | 3389 | 01:17:26 INFO - PROCESS | 3389 | [#4] prototype.html Cycles:180 Average:4109.81 Median:4663.55 stddev:1203.77 (25.8%) stddev-sans-first:1172.41 01:17:26 INFO - PROCESS | 3389 | Values: 284.6 289.6 294.9 301.4 303.6 4775.8 4778.8 4803.0 4812.8 4818.5 4705.0 4705.2 4741.8 4756.4 4765.2 3731.2 3745.7 3750.1 3762.4 3771.3 3681.1 3774.5 3775.5 3817.7 3818.4 3684.9 3736.2 3740.4 3745.0 3752.9 3700.8 3718.4 3720.0 3721.2 3731.2 3057.0 3154.4 3300.2 3302.3 3314.6 4481.7 4623.7 4642.2 4661.1 4661.7 4248.4 4253.6 4261.3 4272.1 4272.3 4859.9 4915.5 4976.2 4985.5 4996.8 3598.6 3602.2 3603.9 3608.7 3612.3 5139.4 5152.3 5157.5 5183.7 5195.5 3689.5 3697.2 3712.3 3716.4 3732.5 3669.5 3721.2 3736.7 3742.1 3780.4 4184.8 4204.2 4217.1 4238.9 4241.6 4939.6 4966.1 4985.5 4996.9 5042.3 1255.3 1262.7 1289.7 1293.9 1294.2 824.9 840.2 841.9 851.5 852.6 3999.8 4003.6 4004.4 4041.6 4057.6 4575.2 4599.0 4608.9 4652.4 4665.4 3881.2 3942.4 4039.9 4056.9 4061.6 2436.1 2456.8 2458.5 2461.2 2478.8 4308.7 4575.6 4709.6 4741.5 4795.9 5244.2 5245.6 5270.8 5285.7 5310.7 4851.4 4861.1 4876.0 4879.2 4882.1 5034.5 5136.5 5165.2 5175.4 5187.4 5080.5 5082.3 5085.9 5111.3 5115.8 4855.6 4862.5 4862.8 4876.7 4887.7 3410.5 3578.4 3639.9 3640.1 3641.8 5157.5 5170.6 5170.8 5178.0 5192.9 5012.1 5019.5 5029.2 5056.8 5056.8 4882.0 4904.6 4962.3 4974.2 4980.4 4898.7 4909.3 4910.8 4911.2 4914.7 5029.4 5053.5 5084.7 5090.4 5104.0 4756.7 4897.8 4914.7 4927.8 4932.6 01:17:26 INFO - PROCESS | 3389 | 01:17:26 INFO - PROCESS | 3389 | [#5] yui.html Cycles:180 Average:17342.32 Median:558.47 stddev:26186.73 (4689.0%) stddev-sans-first:26229.93 01:17:26 INFO - PROCESS | 3389 | Values: 577.1 577.4 580.5 581.9 588.4 10562.7 10817.1 11454.0 11492.3 11924.7 11543.1 11907.9 11918.3 11942.4 11990.8 721.0 721.0 721.2 724.9 727.3 616.7 617.5 626.0 638.1 770.4 667.9 780.5 782.2 787.6 817.9 773.7 774.9 775.8 775.8 779.0 562.0 562.6 564.4 565.5 566.6 8612.1 8925.3 10484.5 10910.6 10946.3 11514.4 11658.3 11773.5 11913.3 12875.7 10338.0 10373.2 10392.7 10509.3 10612.8 3300.3 3301.9 3306.4 3390.8 3397.0 50224.0 52063.2 52221.0 65238.0 65517.9 9387.3 9697.8 10027.4 10034.2 10285.9 17079.2 17210.4 17393.2 17438.8 17486.7 6427.1 6475.8 6523.8 6587.6 6856.2 3542.6 3587.0 3595.3 3602.3 3646.5 2741.1 2817.4 2823.3 2832.1 2842.0 510.8 511.7 513.5 515.9 526.4 501.8 530.8 544.3 551.5 555.8 7761.8 7890.9 7948.7 7967.9 8016.4 478.9 542.3 544.2 546.8 561.1 3580.2 3691.0 3830.2 3845.2 3957.2 78492.0 103208.5 104602.0 105573.0 108580.0 87372.0 89901.6 90232.5 90330.5 90915.5 59321.0 77691.2 78674.0 79009.2 80296.2 7470.6 7614.9 7680.2 7746.2 7785.8 44209.0 44925.8 46786.5 47043.0 47212.5 60496.0 65511.7 65642.0 65681.0 65694.0 9053.2 9610.7 9711.3 9776.8 9810.4 10751.3 10841.2 10865.2 11037.2 11106.7 10135.9 10215.2 10218.9 10312.6 10577.9 9046.5 9062.2 9114.2 9358.7 9460.4 9827.6 10417.6 10782.2 10954.7 11196.3 8133.9 8174.4 8419.3 8448.5 8562.4 8505.7 8560.8 8795.4 8972.9 9053.1 01:17:26 INFO - PROCESS | 3389 | -------- Summary: end -------- 01:17:26 INFO - PROCESS | 3389 | 01:17:27 INFO - TEST-INFO | 3389: exit 0 01:17:27 INFO - TEST-OK | dromaeo_css | took 1124619ms 01:17:27 INFO - TEST-START | kraken 01:17:27 INFO - operating with platform_type : linux_ 01:17:27 INFO - Initialising browser for kraken test... 01:17:27 INFO - TEST-INFO | started process 3732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn3cUjL/profile http://localhost:50604/getInfo.html) 01:17:31 INFO - PROCESS | 3732 | __metrics Screen width/height:1600/1200 01:17:31 INFO - PROCESS | 3732 | colorDepth:24 01:17:31 INFO - PROCESS | 3732 | Browser inner width/height: 1024/697 01:17:31 INFO - PROCESS | 3732 | __metrics 01:17:32 INFO - PROCESS | 3732 | 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" 01:17:32 INFO - PROCESS | 3732 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:17:33 INFO - PROCESS | 3732 | console.error: PushService: 01:17:33 INFO - PROCESS | 3732 | stateChangeProcessEnqueue: Error transitioning state 01:17:33 INFO - PROCESS | 3732 | UnknownError 01:17:33 INFO - TEST-INFO | 3732: exit 0 01:17:33 INFO - Browser initialized. 01:17:33 INFO - Running cycle 1/1 for kraken test... 01:17:33 INFO - TEST-INFO | started process 3814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn3cUjL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:17:46 INFO - PROCESS | 3814 | RSS: Main: 175497216 01:17:46 INFO - PROCESS | 3814 | 01:17:48 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50604/tests/kraken/driver.html?testName=audio-beat-detection) 01:17:49 INFO - PROCESS | 3814 | RSS: Main: 242429952 01:17:49 INFO - PROCESS | 3814 | 01:17:52 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50604/tests/kraken/driver.html?testName=audio-dft) 01:17:53 INFO - PROCESS | 3814 | RSS: Main: 218685440 01:17:53 INFO - PROCESS | 3814 | 01:17:56 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50604/tests/kraken/driver.html?testName=audio-fft) 01:17:56 INFO - PROCESS | 3814 | RSS: Main: 300777472 01:17:56 INFO - PROCESS | 3814 | 01:17:59 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50604/tests/kraken/driver.html?testName=audio-oscillator) 01:17:59 INFO - PROCESS | 3814 | RSS: Main: 209022976 01:17:59 INFO - PROCESS | 3814 | 01:18:02 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50604/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:18:02 INFO - PROCESS | 3814 | RSS: Main: 213979136 01:18:02 INFO - PROCESS | 3814 | 01:18:05 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50604/tests/kraken/driver.html?testName=imaging-darkroom) 01:18:06 INFO - PROCESS | 3814 | RSS: Main: 250159104 01:18:06 INFO - PROCESS | 3814 | 01:18:09 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50604/tests/kraken/driver.html?testName=imaging-desaturate) 01:18:10 INFO - PROCESS | 3814 | RSS: Main: 249618432 01:18:10 INFO - PROCESS | 3814 | 01:18:13 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50604/tests/kraken/driver.html?testName=json-parse-financial) 01:18:14 INFO - PROCESS | 3814 | RSS: Main: 249540608 01:18:14 INFO - PROCESS | 3814 | 01:18:15 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50604/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:18:16 INFO - PROCESS | 3814 | RSS: Main: 211632128 01:18:16 INFO - PROCESS | 3814 | 01:18:18 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50604/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:18:18 INFO - PROCESS | 3814 | RSS: Main: 219627520 01:18:18 INFO - PROCESS | 3814 | 01:18:21 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50604/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:18:21 INFO - PROCESS | 3814 | RSS: Main: 224518144 01:18:21 INFO - PROCESS | 3814 | 01:18:25 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:18:25 INFO - PROCESS | 3814 | RSS: Main: 218308608 01:18:25 INFO - PROCESS | 3814 | 01:18:28 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:18:29 INFO - PROCESS | 3814 | RSS: Main: 222744576 01:18:29 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:50604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50604/tests/kraken/driver.html?testName=ai-astar) 01:18:31 INFO - PROCESS | 3814 | RSS: Main: 275161088 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | __start_tp_report 01:18:31 INFO - PROCESS | 3814 | _x_x_mozilla_page_load 01:18:31 INFO - PROCESS | 3814 | _x_x_mozilla_page_load_details 01:18:31 INFO - PROCESS | 3814 | |i|pagename|runs| 01:18:31 INFO - PROCESS | 3814 | |0;ai-astar;112;115;115;116;115;115;115;115;113;113 01:18:31 INFO - PROCESS | 3814 | |1;audio-beat-detection;155;130;127;179;132;129;137;132;169;126 01:18:31 INFO - PROCESS | 3814 | |2;audio-dft;161;161;162;160;161;163;164;161;160;161 01:18:31 INFO - PROCESS | 3814 | |3;audio-fft;76;75;75;108;76;76;77;76;103;76 01:18:31 INFO - PROCESS | 3814 | |4;audio-oscillator;84;85;114;83;84;84;105;83;90;113 01:18:31 INFO - PROCESS | 3814 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;118;117;117 01:18:31 INFO - PROCESS | 3814 | |6;imaging-darkroom;147;146;147;147;147;146;147;147;147;146 01:18:31 INFO - PROCESS | 3814 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;94 01:18:31 INFO - PROCESS | 3814 | |8;json-parse-financial;64;62;63;63;63;66;64;64;64;63 01:18:31 INFO - PROCESS | 3814 | |9;json-stringify-tinderbox;66;66;67;67;66;67;67;67;72;67 01:18:31 INFO - PROCESS | 3814 | |10;stanford-crypto-aes;85;83;83;83;84;87;84;84;84;93 01:18:31 INFO - PROCESS | 3814 | |11;stanford-crypto-ccm;141;140;142;152;158;150;150;149;166;149 01:18:31 INFO - PROCESS | 3814 | |12;stanford-crypto-pbkdf2;172;172;173;174;173;174;172;171;172;173 01:18:31 INFO - PROCESS | 3814 | |13;stanford-crypto-sha256-iterative;73;75;71;70;69;73;70;69;69;68 01:18:31 INFO - PROCESS | 3814 | __end_tp_report 01:18:31 INFO - PROCESS | 3814 | __start_cc_report 01:18:31 INFO - PROCESS | 3814 | _x_x_mozilla_cycle_collect,1922 01:18:31 INFO - PROCESS | 3814 | __end_cc_report 01:18:31 INFO - PROCESS | 3814 | __startTimestamp1475309911257__endTimestamp 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | ------- Summary: start ------- 01:18:31 INFO - PROCESS | 3814 | Number of tests: 14 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:1.26 (1.1%) stddev-sans-first:1.00 01:18:31 INFO - PROCESS | 3814 | Values: 112.0 115.0 115.0 116.0 115.0 115.0 115.0 115.0 113.0 113.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:134.50 stddev:19.10 (14.2%) stddev-sans-first:19.64 01:18:31 INFO - PROCESS | 3814 | Values: 155.0 130.0 127.0 179.0 132.0 129.0 137.0 132.0 169.0 126.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 01:18:31 INFO - PROCESS | 3814 | Values: 161.0 161.0 162.0 160.0 161.0 163.0 164.0 161.0 160.0 161.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.56 (16.5%) stddev-sans-first:13.14 01:18:31 INFO - PROCESS | 3814 | Values: 76.0 75.0 75.0 108.0 76.0 76.0 77.0 76.0 103.0 76.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:84.00 stddev:12.90 (15.4%) stddev-sans-first:13.31 01:18:31 INFO - PROCESS | 3814 | Values: 84.0 85.0 114.0 83.0 84.0 84.0 105.0 83.0 90.0 113.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 01:18:31 INFO - PROCESS | 3814 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 01:18:31 INFO - PROCESS | 3814 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 01:18:31 INFO - PROCESS | 3814 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 01:18:31 INFO - PROCESS | 3814 | Values: 64.0 62.0 63.0 63.0 63.0 66.0 64.0 64.0 64.0 63.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:1.75 (2.6%) stddev-sans-first:1.80 01:18:31 INFO - PROCESS | 3814 | Values: 66.0 66.0 67.0 67.0 66.0 67.0 67.0 67.0 72.0 67.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:3.06 (3.6%) stddev-sans-first:3.24 01:18:31 INFO - PROCESS | 3814 | Values: 85.0 83.0 83.0 83.0 84.0 87.0 84.0 84.0 84.0 93.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#11] stanford-crypto-ccm Cycles:10 Average:149.70 Median:150.00 stddev:7.96 (5.3%) stddev-sans-first:7.79 01:18:31 INFO - PROCESS | 3814 | Values: 141.0 140.0 142.0 152.0 158.0 150.0 150.0 149.0 166.0 149.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:173.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 01:18:31 INFO - PROCESS | 3814 | Values: 172.0 172.0 173.0 174.0 173.0 174.0 172.0 171.0 172.0 173.0 01:18:31 INFO - PROCESS | 3814 | 01:18:31 INFO - PROCESS | 3814 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:2.26 (3.2%) stddev-sans-first:2.24 01:18:31 INFO - PROCESS | 3814 | Values: 73.0 75.0 71.0 70.0 69.0 73.0 70.0 69.0 69.0 68.0 01:18:31 INFO - PROCESS | 3814 | -------- Summary: end -------- 01:18:31 INFO - PROCESS | 3814 | 01:18:32 INFO - TEST-INFO | 3814: exit 0 01:18:32 INFO - TEST-OK | kraken | took 65542ms 01:18:32 INFO - SUITE-END | took 1190s 01:18:32 INFO - Completed test suite (00:19:50) 01:18:32 INFO - javascript benchmark 01:18:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.75786800254, 2582.4576838863836, 2609.7520735530125, 2619.5415802234616, 2632.0129951268273, 4504.504504504502, 4559.247724125524, 4679.649026323026, 4695.788689508971, 4708.317293992373, 4568.908621827562, 4588.7476188809605, 4594.931076033862, 4601.585857272845, 4603.4706008809, 4224.0, 4249.3413520904305, 4253.3619957006385, 4276.25165596021, 4309.26742453782, 4327.5888790565, 4330.84842030529, 4351.738895666254, 4361.60745532902, 4395.0, 4325.675574331922, 4334.696571240014, 4384.4519435070615, 4387.341898715203, 4433.578810013044, 4248.745075295492, 4340.739555626641, 4368.388425620416, 4375.2124617568825, 4378.0, 4296.462942132233, 4307.741535507879, 4343.413639158736, 4369.344598310247, 4389.890252743675, 4504.256797628387, 4539.863804085882, 4550.203714350008, 4605.700629459075, 4632.675712700112, 4872.123017856784, 4907.386576677915, 4931.284963680282, 4979.825706100269, 4980.676256043345, 4898.02039592083, 4927.285543596195, 4927.384076990376, 4929.433115191763, 4942.283368911523, 4640.9535904640525, 4643.95356046442, 4644.674872758942, 4689.39037925071, 4705.976470117696, 4921.876953076202, 4975.651704380659, 5059.822906198266, 5090.134677104901, 5117.104506711311, 4844.975775121102, 4911.3369695090705, 4911.386076740408, 4913.9017219656125, 4968.552830245295, 4951.950480495221, 4954.40547134339, 4958.206686930074, 4962.280469331927, 4982.501749824988, 4750.809967601326, 4771.06964141989, 4833.3958255218095, 4877.3903262092235, 4955.702657840541, 4890.119778439844, 4903.043906438282, 4914.803407863646, 4917.827876024322, 4955.108080545464, 4231.301835197158, 4240.1307731914885, 4241.406203131564, 4280.443542339476, 4291.0559676871035, 3638.581563120275, 3667.74325797197, 3687.9815600921825, 3689.870854520079, 3753.042974041602, 4166.729162604421, 4210.852620158341, 4216.494020717533, 4241.130568233505, 4260.595243451867, 4878.731669758197, 4878.756062196876, 4884.0476107159475, 4932.26016097581, 4938.037082768898, 4231.513375961804, 4231.640310573574, 4236.046889449849, 4237.322028475429, 4282.272013757669, 4402.097569998143, 4404.317330813729, 4461.776911154429, 4463.977680111579, 4512.706674066241, 4607.7004994675235, 4661.254199328091, 4662.370579971661, 4664.463586687574, 4664.79008444614, 4908.705477671351, 4971.527704868032, 4982.327385803015, 4983.352164218629, 4983.426905905722, 4593.425821772278, 4631.907361852676, 4654.348391225299, 4661.230896901973, 4683.601893839062, 4926.3842019747535, 4936.407631084293, 4937.086638971802, 4997.350344455343, 5000.149974504416, 4983.925241121458, 4992.226204938241, 4994.850154495371, 4998.825041123543, 5059.038782631288, 4697.553732395417, 4729.574338309569, 4863.610911127031, 4876.512348765095, 4932.926006109983, 4750.0, 4786.875084355104, 4822.9758851205515, 4833.3958255218095, 4891.144049791201, 4740.146773580788, 4744.4069491313585, 4749.26386410107, 4754.809807607657, 4806.7836947338155, 4747.8575642730775, 4857.368542089505, 4858.854234372974, 4867.9269810952155, 4932.679375840559, 4691.202495575829, 4715.976420117878, 4753.738544379954, 4759.738214398241, 4761.833335833229], "value": 4552.902226808393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.2282649943079, 568.91466280058, 574.1559906936801, 577.1112486770373, 585.7364186116249, 27817.582736258948, 38363.42454863176, 39898.80050599747, 39974.0, 43766.7811660942, 39864.0, 40245.39631905524, 40309.59690403095, 40313.7984310078, 40328.59671403285, 7612.58130802807, 7798.2981531662135, 7800.804979875492, 7803.765887023398, 7806.5316081035035, 7650.043744531934, 7734.342580880604, 7734.690612375498, 7736.1877002914725, 7736.690532378698, 7731.265529774662, 7761.805954851117, 7777.688892444296, 7777.766666999971, 7789.337906277973, 7697.692092316301, 7749.651265693057, 7758.534487930742, 7761.379089672812, 7761.45669803114, 7611.3149816516225, 7685.385169186452, 7685.923140768577, 7685.961570192169, 7687.615619219073, 38114.42828357577, 38303.0, 38424.231515369815, 38510.0, 38520.0, 2679.249810053169, 2816.2959260184953, 2980.3741214345014, 2983.5518332697625, 3397.252604427022, 28338.14985550437, 28556.571651425245, 28976.565351519745, 29315.853420732972, 29907.25231869199, 3120.60992375953, 3222.0179485527597, 3350.3466823969093, 3433.1931995980926, 3479.7216222702123, 200898.0, 201952.0, 205143.0, 259092.704536478, 260573.0, 56409.0, 57134.714326428104, 57179.71410143006, 57195.42804571984, 57295.42704572984, 33786.32427351488, 34265.0, 34338.656613433544, 36229.45655815165, 36252.0, 13096.14875033139, 13296.734065318833, 13299.734005320033, 13310.267935263653, 13320.200787952754, 9909.900900991042, 10023.649172278936, 10033.046860548237, 10038.44788536623, 10039.548220330104, 18625.906870465562, 18714.064296785105, 18716.906415467834, 18785.90607046956, 18802.905985469984, 7082.716691332392, 7152.964235178791, 7278.272172782679, 7295.708171673074, 7452.739154129579, 771.9845603087907, 845.678642115992, 898.5821592959174, 916.3860213656866, 935.5228833295068, 26711.866440667673, 27146.185614431597, 27451.0, 27692.0, 28159.43681126366, 903.8644203369415, 908.1100521488978, 916.4959272400154, 919.9696340099132, 964.8552717092352, 14620.926895365668, 15021.774673379909, 15030.699386012218, 15038.0, 15095.924520377328, 365705.0, 366578.0, 370237.0, 372244.0, 372686.0, 47777.522224778004, 47809.76095119502, 47921.0, 48118.27822582664, 48317.275240871415, 1031.7884833609091, 1061.2040969273046, 1067.3115840283128, 1161.7734541764444, 1180.167981572989, 21264.681029784875, 28714.0, 28740.712592873802, 31342.216444588157, 31941.722331106495, 46701.53298466972, 47259.76370118265, 47280.290795637404, 47296.0, 47373.0, 324699.9065098225, 325188.0, 326480.0, 326857.0, 328160.0, 22203.1118755248, 22780.886095569414, 24844.751552484966, 25667.3583160415, 26081.347966300993, 38004.809975949946, 40072.0, 40245.79877100596, 40577.79711101425, 41844.3723344144, 35189.472157918164, 35212.0, 35269.64730352664, 35287.82356088203, 36031.31592892907, 35222.11944701403, 35404.64595354014, 35820.28359432745, 35987.280254394245, 36022.4596631056, 29717.85141074367, 30161.698383016766, 33513.72245844631, 34218.82890585531, 34620.480692789126, 30802.537961930142, 32259.677403226608, 32517.34965300728, 32580.0, 32713.836430817693, 24916.75083249217, 24963.875180624706, 25045.373865653506, 25172.74827251704, 25587.6161857576], "value": 17000.738181462257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.0242117229414, 360.2506785885359, 360.82860641195435, 369.06810303982445, 382.44354464254513, 12242.143049986504, 12658.0, 16006.0, 16240.350385984577, 16910.492685219433, 15076.6984660307, 15256.771148432783, 15354.46259380919, 17005.064721440314, 17097.743533847002, 4037.838486460538, 4898.24077268024, 5130.974345128269, 5138.100832354342, 5141.948580514184, 5799.826005219829, 5948.315943666469, 6001.759929602811, 6009.06859436788, 6012.338642749294, 5153.896922061556, 5431.592630552705, 5993.041113421853, 5996.550258730591, 6002.609830361034, 5493.23094766733, 5525.336959564837, 5526.447355264441, 5535.972320138414, 5537.446255374471, 5213.400458947193, 5328.280682107905, 5370.462953704638, 5382.058139825514, 5392.325959255093, 11842.0, 11891.583794567148, 11998.760024799543, 12017.158798884082, 12500.187487813353, 1724.6292047209786, 1804.106967051305, 1812.247917114396, 1812.4019073705645, 1832.5235438786012, 8542.316614670874, 9074.818503629891, 9116.498592577405, 9431.481268530297, 9592.08875156859, 1709.350446830209, 1720.698877696398, 1741.7126174181244, 1809.8280663336961, 1820.8816426932208, 65648.3435165647, 65680.0, 67973.3202667972, 68685.31314686839, 68865.0, 9325.813483730288, 9480.762980925394, 9865.704028879145, 9879.16027137687, 10096.444695541815, 13306.600801975956, 13560.321983900765, 13580.45678172862, 13731.0, 13756.380962856496, 6715.429188518933, 6893.620850853151, 6900.137482814648, 7015.333543313377, 7027.1701922452385, 6367.713452894631, 6403.48772098231, 6515.576487528296, 6593.571417857824, 6608.107905432801, 4174.937375939303, 4225.72532785368, 4237.512686041083, 4368.8907777305185, 4377.0808130293, 1761.330694336144, 1881.1346780481133, 1893.0028819595184, 1908.5133291010704, 1913.1295260656368, 733.9559626422432, 831.5966756123275, 833.083608031173, 867.6399294292797, 927.2581934452411, 16047.759283610756, 17371.218295176746, 17387.826121738875, 17658.293668253125, 17758.46724598264, 796.3828033274259, 798.4769975665948, 853.389826274217, 882.748416701237, 889.1197714262834, 9236.214921731593, 9438.339316247797, 9744.415335079777, 9784.608615655436, 9830.705078847646, 344675.0, 356385.0, 356897.0, 356998.0, 357330.0, 73930.0, 74549.0, 75796.0, 77234.61382693051, 79271.0, 846.7967687755017, 864.2653744317406, 869.3783944479601, 890.1410139215687, 890.6660002499062, 14625.34185961613, 15035.323410446337, 15298.61753456128, 15414.152221627917, 15613.297401616728, 34639.30721385508, 35784.821075894455, 36750.8162459186, 36765.63234367622, 36985.26029479449, 47006.529934700215, 47217.0, 48005.27992080191, 48128.27807582959, 55865.72067139638, 6484.416402523795, 6744.966275168593, 7074.398676112588, 7105.18290396611, 7369.963150184215, 8984.86522702147, 11066.833997489883, 11824.527018919147, 12430.502779889064, 12644.810327845275, 9448.811023779623, 9509.239260859253, 9713.222942164752, 9790.608375665179, 10043.0, 10253.231007674603, 10314.793704125725, 10404.479776011018, 10801.621943231949, 10894.182936279652, 9799.85300220483, 9885.654002109892, 9935.751606209902, 9980.900190998287, 10322.174226062047, 7095.270815283944, 7156.534825236343, 7436.776896693108, 7492.063492063492, 7518.135414427411, 8608.311335093304, 9123.635054597742, 9423.246140308622, 9641.11255109156, 9704.369216000938], "value": 7887.356609970976, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.5177580743507, 1328.574856046065, 1391.5616580777055, 1446.443119399031, 1656.9834301656988, 6706.66466676666, 7323.560586364815, 7505.099388073439, 7713.6914523419, 7715.807104822382, 7719.112302085262, 7779.844403111949, 7783.338416234613, 7791.493552919056, 7798.454108212427, 2130.2650585547963, 2175.8476906616465, 2176.880271585062, 2187.267265466071, 2193.8683678979314, 2097.528056187361, 2142.6678864775986, 2171.109844963565, 2171.392010237128, 2185.650295952648, 2114.619368513667, 2116.608427440921, 2121.586290673319, 2127.2235633993637, 2190.0582749417745, 2106.683997400387, 2112.2501511963187, 2112.7675955644945, 2114.12263910477, 2117.14255726431, 2017.2334512885157, 2079.1579410338686, 2083.4895450614545, 2090.34154241415, 2094.6857971304426, 7707.768766937001, 7799.298063174285, 7834.255745704149, 7868.173841746591, 7876.488028278143, 4261.659067274611, 4413.249747542925, 4432.401625780511, 4447.888802779924, 4457.309117086825, 2880.35192081782, 3048.84755762211, 3077.9538306925415, 3099.0857696979447, 3112.5331200319906, 838.6771093129129, 847.2840449819893, 853.3898262742107, 876.5222953490363, 884.752269364579, 10443.216758743049, 10453.581856725721, 10463.05832475081, 10524.315919465287, 10544.683659490227, 3708.981455092707, 3945.5265368156006, 4015.257177422186, 4064.1262128642484, 4076.510818701775, 8249.752507424786, 8250.298724608356, 8251.95874020626, 8253.298469630148, 8253.79365515867, 4320.611144996966, 4322.286822674287, 4323.221820072355, 4325.98339390243, 4326.675499337499, 3521.190126270972, 3626.437902125175, 3866.516685414323, 3953.7034722395933, 3981.641652251253, 3247.2531317796565, 3340.799552026838, 3392.9830350848088, 3409.846556904896, 3413.061408112739, 999.7200783780553, 1015.761296095417, 1017.9032991865761, 1018.8573599696049, 1025.179856115105, 737.1228238396292, 768.7655265144073, 770.2105342024357, 778.4978688745728, 799.8040480082301, 4758.571728544448, 4849.781759820817, 4930.411533944708, 4990.4011518618, 5086.516780905808, 789.9723509677134, 793.9682412703543, 799.3525244551931, 816.7508909782455, 823.9876401853977, 3113.8598763055716, 3196.1370429983776, 3299.488579270217, 3320.7177389922126, 3375.5105509700957, 9469.857952130724, 9890.703278901645, 9913.75215619601, 9926.0, 9936.105750482491, 9829.066238707312, 9838.458884761407, 9839.754006149904, 9844.261680373857, 9849.45827979468, 7230.42156627479, 7231.710731570678, 7246.970848162523, 7356.301151390609, 7409.88885166723, 4616.930746038879, 4701.059788042337, 4740.19416699155, 4785.258284965836, 4857.708537487762, 8960.103989600988, 9021.458712477272, 9029.954850225708, 9044.592993315186, 9114.908850911406, 8397.70608028716, 8821.073787252502, 8852.24755895756, 9073.954630226806, 9161.954190229006, 5947.750972295867, 6535.379138981979, 6704.83237919056, 6705.396514313735, 6727.529072964846, 6618.404343609098, 6816.250212476524, 6825.55633883796, 6828.5902845829405, 6829.146356705412, 5794.0, 5819.0, 5989.3711160329285, 6210.285817130907, 6325.146105275913, 6087.634741915499, 6163.599366041193, 6188.381161883775, 6225.968870155621, 6233.0338797486465, 5664.178694089252, 5682.744276507485, 5748.396418376177, 5748.913766293593, 5751.424857514383, 4234.386014027887, 4249.575042495726, 4260.147970405869, 4325.653947684114, 4342.652587793033, 4176.582341765799, 4277.1873344064525, 4318.071614602875, 4319.503257125345, 4340.197063543254], "value": 3943.8562945643357, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.5674574646537, 289.59601356108226, 294.92646765772594, 301.38968588608077, 303.6037970448564, 4775.832845850396, 4778.832740854071, 4802.95197048029, 4812.807487700487, 4818.494058123894, 4704.952950470502, 4705.17689386368, 4741.834035808747, 4756.381670382854, 4765.166095933215, 3731.235096805162, 3745.719071069667, 3750.1187221003042, 3762.4168253920548, 3771.283456143324, 3681.11653203232, 3774.5470543534816, 3775.490308808317, 3817.7136714746366, 3818.3890577507605, 3684.926301473969, 3736.1967177056927, 3740.438934159884, 3744.988853009686, 3752.924941501168, 3700.7594506357, 3718.4236443351324, 3720.0, 3721.218544105741, 3731.1977924746175, 3057.0, 3154.41643295991, 3300.1914530939835, 3302.339532093591, 3314.585676790401, 4481.6638752093395, 4623.69945953512, 4642.210824159901, 4661.067786442691, 4661.650376221763, 4248.362745588156, 4253.553376895412, 4261.339492378686, 4272.145570885804, 4272.252355837716, 4859.860768374106, 4915.5330243626795, 4976.178930476467, 4985.501449855022, 4996.825111121129, 3598.5681718193982, 3602.225521512887, 3603.855845766166, 3608.657177568127, 3612.259486805199, 5139.383274007106, 5152.252923326097, 5157.530103920402, 5183.663061900965, 5195.5324020837925, 3689.5241903238384, 3697.242065376591, 3712.3132220539287, 3716.3867961786004, 3732.496113024707, 3669.4679271506016, 3721.218544105768, 3736.7010639148803, 3742.1393079591303, 3780.3762379207674, 4184.832606695698, 4204.180184863983, 4217.093324935154, 4238.87283381499, 4241.618254357123, 4939.580135688435, 4966.1061009018, 4985.451600323961, 4996.90006199874, 5042.268871013683, 1255.253124390986, 1262.6780171056505, 1289.6775806048488, 1293.9260413856477, 1294.1911305434103, 824.9216324449168, 840.1682334488934, 841.9013187789993, 851.4805968359295, 852.5822347050025, 3999.7600143991453, 4003.5796241394232, 4004.3582131326016, 4041.5958404159937, 4057.634812866856, 4575.199340115467, 4598.97700511502, 4608.907821843544, 4652.395188625457, 4665.440147182292, 3881.223755248905, 3942.4086387042175, 4039.8788036358956, 4056.9188616228103, 4061.5532291447917, 2436.1229957215387, 2456.7666071723156, 2458.4591389894554, 2461.2124120281337, 2478.8388754730886, 4308.6983911126545, 4575.565321294472, 4709.634206080267, 4741.454732705783, 4795.904081918412, 5244.239585260192, 5245.554127899171, 5270.841874743764, 5285.709285989307, 5310.707911064928, 4851.417829860439, 4861.149298872754, 4875.975620121948, 4879.243717223836, 4882.145624515767, 5034.546890779848, 5136.460671629575, 5165.225216217597, 5175.378954525481, 5187.377514698261, 5080.542751152414, 5082.263071854634, 5085.949140508547, 5111.3355263815465, 5115.846524604268, 4855.611551075976, 4862.513748625109, 4862.805487780449, 4876.683015603974, 4887.657863949632, 3410.505476705814, 3578.3916734154736, 3639.908027591659, 3640.0535860675886, 3641.8361173747776, 5157.484251574962, 5170.6380553360905, 5170.819021334235, 5178.0, 5192.896142077062, 5012.097822392005, 5019.472955339783, 5029.1953287473825, 5056.772445240046, 5056.811649262347, 4881.951180488291, 4904.632152588499, 4962.3052772611145, 4974.204127339608, 4980.377452818398, 4898.681585696918, 4909.257213689231, 4910.796854770461, 4911.214205727067, 4914.70511769295, 5029.396472423186, 5053.494650534917, 5084.694918304914, 5090.440051594248, 5103.974480127576, 4756.7145971241835, 4897.755112244302, 4914.729689867092, 4927.802887884444, 4932.580730637936], "value": 3728.1896073919247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.0593931891019, 577.4254616656427, 580.4688709830504, 581.9272590926134, 588.4380416702048, 10562.735931601695, 10817.134629229662, 11454.02640775534, 11492.310461372323, 11924.701882452942, 11543.076553875691, 11907.880921190806, 11918.28490290581, 11942.402879856016, 11990.7601847963, 721.019413597507, 721.0266140710052, 721.2462976189894, 724.8586525627492, 727.2618292433184, 616.6762449713891, 617.5090802811775, 626.0171530696808, 638.0620487882804, 770.4337312075648, 667.9031540426636, 780.5355813291083, 782.2138750555683, 787.629813987425, 817.9222973817508, 773.6827900560743, 774.9263819937097, 775.8293175501381, 775.8370742144157, 778.9766307010799, 562.0304973919955, 562.6202313438413, 564.4045531963776, 565.547561950438, 566.5637459156468, 8612.095729948327, 8925.330600204945, 10484.528196231187, 10910.563577456893, 10946.343219406781, 11514.424278786028, 11658.300501969909, 11773.470193841298, 11913.285202887855, 12875.67810804728, 10338.0, 10373.222008349328, 10392.740181495448, 10509.31689440184, 10612.840807387895, 3300.2574420755377, 3301.933961320784, 3306.437905556061, 3390.847411866472, 3397.048826328632, 50224.0, 52063.21905171463, 52221.0, 65237.99999999953, 65517.86196346633, 9387.29595280343, 9697.757556061155, 10027.448490332956, 10034.197264218845, 10285.897141028643, 17079.231434585472, 17210.39763608268, 17393.217305221297, 17438.82561174372, 17486.737698934525, 6427.132337134521, 6475.838104047437, 6523.7716679915975, 6587.604743715392, 6856.177258728984, 3542.6457354264367, 3587.0494319005484, 3595.3168897909313, 3602.2615363850346, 3646.4530320452145, 2741.1091395296608, 2817.4365126974685, 2823.3365159187574, 2832.1361984594896, 2841.962683620464, 510.83908568800706, 511.66741617948634, 513.5480776916289, 515.9484051594885, 526.3920172201114, 501.79175642108845, 530.7770736290768, 544.257089073412, 551.48987186852, 555.7832445346318, 7761.844763104819, 7890.8816367754525, 7948.682052717826, 7967.922124911418, 8016.438849280611, 478.9233722604367, 542.2544001997254, 544.2353493341861, 546.8359492152339, 561.1498579651831, 3580.2481478889727, 3691.0034290741887, 3830.157365379612, 3845.2309538091936, 3957.231422337201, 78492.0, 103208.48395757974, 104602.0, 105573.0, 108580.0, 87372.0, 89901.55049224712, 90232.5488372567, 90330.54834725785, 90915.54542227379, 59321.0, 77691.2230877684, 78674.0, 79009.20990790133, 80296.19703803003, 7470.551766894004, 7614.923850761422, 7680.155182929761, 7746.186650401627, 7785.805354866174, 44209.0, 44925.77537112294, 46786.532134678215, 47043.0, 47212.527874720814, 60496.0, 65511.672441637485, 65642.0, 65681.0, 65694.0, 9053.230475409664, 9610.675443901253, 9711.320207585684, 9776.80446391054, 9810.411375317504, 10751.301165424222, 10841.18691098155, 10865.239433239598, 11037.227394082338, 11106.722331941766, 10135.949320253647, 10215.233857460571, 10218.897811021794, 10312.639057632947, 10577.894221057999, 9046.54767261621, 9062.184403403726, 9114.179723824887, 9358.672446464341, 9460.385074970105, 9827.557759900965, 10417.583296668352, 10782.1913356497, 10954.671359859218, 11196.328220306481, 8133.877991830009, 8174.427790054639, 8419.284360829399, 8448.535330556879, 8562.400631955703, 8505.659773608986, 8560.828783424422, 8795.428297160664, 8972.926600562429, 9053.139951704577], "value": 6090.501384958896, "unit": "score"}], "name": "dromaeo_css", "value": 6160.77156252976, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 113.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 127.0, 179.0, 132.0, 129.0, 137.0, 132.0, 169.0, 126.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 161.0, 163.0, 164.0, 161.0, 160.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 108.0, 76.0, 76.0, 77.0, 76.0, 103.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 114.0, 83.0, 84.0, 84.0, 105.0, 83.0, 90.0, 113.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 63.0, 66.0, 64.0, 64.0, 64.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 72.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 83.0, 84.0, 87.0, 84.0, 84.0, 84.0, 93.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 142.0, 152.0, 158.0, 150.0, 150.0, 149.0, 166.0, 149.0], "value": 149.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 173.0, 174.0, 173.0, 174.0, 172.0, 171.0, 172.0, 173.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 71.0, 70.0, 69.0, 73.0, 70.0, 69.0, 69.0, 68.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1559.1, "alertThreshold": 2.0}]} 01:18:33 INFO - Return code: 0 01:18:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:18:33 INFO - # TBPL SUCCESS # 01:18:33 INFO - Running post-action listener: _resource_record_post_action 01:18:33 INFO - [mozharness: 2016-10-01 08:18:33.072552Z] Finished run-tests step (success) 01:18:33 INFO - Running post-run listener: _resource_record_post_run 01:18:33 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 11522048; Write bytes: 427773952; Read time: 5252; Write time: 381780 01:18:33 INFO - TinderboxPrint: CPU usage
13.1% 01:18:33 INFO - TinderboxPrint: I/O read bytes / time
11,522,048 / 5,252 01:18:33 INFO - TinderboxPrint: I/O write bytes / time
427,773,952 / 381,780 01:18:33 INFO - TinderboxPrint: CPU idle
8,371.0 (86.9%) 01:18:33 INFO - TinderboxPrint: CPU user
1,205.2 (12.5%) 01:18:33 INFO - TinderboxPrint: Swap in / out
0 / 0 01:18:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 19062784; Read time: 0; Write time: 21260 01:18:33 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 9310208; Write bytes: 336510976; Read time: 4948; Write time: 286264 01:18:33 INFO - Running post-run listener: _upload_blobber_files 01:18:33 INFO - Blob upload gear active. 01:18:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:18:33 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 01:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:18:34 INFO - (blobuploader) - INFO - Open directory for files ... 01:18:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:18:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:18:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:18:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:18:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:18:34 INFO - (blobuploader) - INFO - Done attempting. 01:18:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:18:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:18:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:18:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:18:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:18:35 INFO - (blobuploader) - INFO - Done attempting. 01:18:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:18:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:18:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:18:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:18:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:18:39 INFO - (blobuploader) - INFO - Done attempting. 01:18:39 INFO - (blobuploader) - INFO - Iteration through files over. 01:18:39 INFO - Return code: 0 01:18:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:18:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:18:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b28f3f8f5db246d778c1353ead92a3a373c4532159117515588f204b3ab7d407f44d81458e6d3eee6ce8b2f1f4e7f2c9b08927f6c5aac1b7c09d200f47a360c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28a0f43bfff4eaf6f94f3db3bdbfdd37cf5d67e91a864819a55fbda15ae7e82b826fa82de8f35d84283a4233b055a52d8a2e1c7361fc368cef5391426b87a268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d57e1e69c7b8c5683b5d341e7d5d993055058e323a7acc52ce4420e16ef2b7e6b6b1fab218bb32ee242cfc10ddd853e5ca15de07ed2dfd66d74ef45f2f074a4"} 01:18:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:18:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:18:39 INFO - Contents: 01:18:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b28f3f8f5db246d778c1353ead92a3a373c4532159117515588f204b3ab7d407f44d81458e6d3eee6ce8b2f1f4e7f2c9b08927f6c5aac1b7c09d200f47a360c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28a0f43bfff4eaf6f94f3db3bdbfdd37cf5d67e91a864819a55fbda15ae7e82b826fa82de8f35d84283a4233b055a52d8a2e1c7361fc368cef5391426b87a268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d57e1e69c7b8c5683b5d341e7d5d993055058e323a7acc52ce4420e16ef2b7e6b6b1fab218bb32ee242cfc10ddd853e5ca15de07ed2dfd66d74ef45f2f074a4"} 01:18:39 INFO - Running post-run listener: copy_logs_to_upload_dir 01:18:39 INFO - Copying logs to upload dir... 01:18:39 INFO - mkdir: /builds/slave/test/build/upload/logs 01:18:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.233791 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-10-01 01:18:39.559392) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 01:18:39.562636) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b28f3f8f5db246d778c1353ead92a3a373c4532159117515588f204b3ab7d407f44d81458e6d3eee6ce8b2f1f4e7f2c9b08927f6c5aac1b7c09d200f47a360c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28a0f43bfff4eaf6f94f3db3bdbfdd37cf5d67e91a864819a55fbda15ae7e82b826fa82de8f35d84283a4233b055a52d8a2e1c7361fc368cef5391426b87a268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d57e1e69c7b8c5683b5d341e7d5d993055058e323a7acc52ce4420e16ef2b7e6b6b1fab218bb32ee242cfc10ddd853e5ca15de07ed2dfd66d74ef45f2f074a4"} build_url:https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011115 build_url: 'https://queue.taskcluster.net/v1/task/Iuf8z_LOSWq7PiPUnnE0OQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6b28f3f8f5db246d778c1353ead92a3a373c4532159117515588f204b3ab7d407f44d81458e6d3eee6ce8b2f1f4e7f2c9b08927f6c5aac1b7c09d200f47a360c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28a0f43bfff4eaf6f94f3db3bdbfdd37cf5d67e91a864819a55fbda15ae7e82b826fa82de8f35d84283a4233b055a52d8a2e1c7361fc368cef5391426b87a268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d57e1e69c7b8c5683b5d341e7d5d993055058e323a7acc52ce4420e16ef2b7e6b6b1fab218bb32ee242cfc10ddd853e5ca15de07ed2dfd66d74ef45f2f074a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 01:18:39.588197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 01:18:39.588546) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1475308643.90658-2012270283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 01:18:39.670269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 01:18:39.670587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 01:18:39.670949) ========= ========= Total master_lag: 0.32 =========