builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1475295558.14 results: success (0) buildid: 20160930183005 builduid: b5afcdc88cf946ad832c2e737f6c2074 revision: c8b0d217e5a4a903975eb2a104a3fb5e56899e6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:18.138283) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:18.138838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:18.139205) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:18.255570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:18.255889) ========= 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=232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 21:19:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.3M=0.001s 2016-09-30 21:19:19 (19.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125572 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:18.409661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:18.410059) ========= 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=232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019691 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:18.459584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 21:19:18.459973) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c8b0d217e5a4a903975eb2a104a3fb5e56899e6f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c8b0d217e5a4a903975eb2a104a3fb5e56899e6f --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=232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 21:19:19,308 truncating revision to first 12 chars 2016-09-30 21:19:19,309 Setting DEBUG logging. 2016-09-30 21:19:19,309 attempt 1/10 2016-09-30 21:19:19,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c8b0d217e5a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 21:19:20,353 unpacking tar archive at: mozilla-inbound-c8b0d217e5a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377481 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 21:19:19.854989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:19.855654) ========= script_repo_revision: c8b0d217e5a4a903975eb2a104a3fb5e56899e6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:19.856657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:19.856984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 21:19:19.868265) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-30 21:19:19.868997) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:19:20 INFO - MultiFileLogger online at 20160930 21:19:20 in /builds/slave/test 21:19:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:19:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:19:20 INFO - {'append_to_log': False, 21:19:20 INFO - 'base_work_dir': '/builds/slave/test', 21:19:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:19:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:19:20 INFO - 'branch': 'Mozilla-Inbound', 21:19:20 INFO - 'buildbot_json_path': 'buildprops.json', 21:19:20 INFO - 'config_files': ('talos/linux_config.py',), 21:19:20 INFO - 'default_actions': ('clobber', 21:19:20 INFO - 'read-buildbot-config', 21:19:20 INFO - 'download-and-extract', 21:19:20 INFO - 'populate-webroot', 21:19:20 INFO - 'create-virtualenv', 21:19:20 INFO - 'install', 21:19:20 INFO - 'run-tests'), 21:19:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:19:20 INFO - 'download_minidump_stackwalk': True, 21:19:20 INFO - 'download_symbols': 'ondemand', 21:19:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:19:20 INFO - 'tooltool.py': '/tools/tooltool.py', 21:19:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:19:20 INFO - '/tools/misc-python/virtualenv.py')}, 21:19:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:19:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:19:20 INFO - 'installer_path': 'installer.exe', 21:19:20 INFO - 'log_level': 'info', 21:19:20 INFO - 'log_name': 'talos', 21:19:20 INFO - 'log_to_console': True, 21:19:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:19:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:19:20 INFO - 'opt_config_files': (), 21:19:20 INFO - 'pip_index': False, 21:19:20 INFO - 'sps_profile': False, 21:19:20 INFO - 'sps_profile_interval': 0, 21:19:20 INFO - 'suite': 'dromaeojs', 21:19:20 INFO - 'system_bits': '32', 21:19:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:19:20 INFO - 'title': 'talos-linux64-ix-025', 21:19:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:19:20 INFO - 'use_talos_json': True, 21:19:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:19:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:19:20 INFO - 'work_dir': 'build'} 21:19:20 INFO - [mozharness: 2016-10-01 04:19:20.823978Z] Running clobber step. 21:19:20 INFO - Running pre-action listener: _resource_record_pre_action 21:19:20 INFO - Running main action method: clobber 21:19:20 INFO - rmtree: /builds/slave/test/build 21:19:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:19:21 INFO - Running post-action listener: _resource_record_post_action 21:19:21 INFO - [mozharness: 2016-10-01 04:19:21.810079Z] Finished clobber step (success) 21:19:21 INFO - [mozharness: 2016-10-01 04:19:21.810180Z] Running read-buildbot-config step. 21:19:21 INFO - Running pre-action listener: _resource_record_pre_action 21:19:21 INFO - Running main action method: read_buildbot_config 21:19:21 INFO - Using buildbot properties: 21:19:21 INFO - { 21:19:21 INFO - "project": "", 21:19:21 INFO - "product": "firefox", 21:19:21 INFO - "script_repo_revision": "production", 21:19:21 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:19:21 INFO - "repository": "", 21:19:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:19:21 INFO - "buildid": "20160930183005", 21:19:21 INFO - "pgo_build": "True", 21:19:21 INFO - "basedir": "/builds/slave/test", 21:19:21 INFO - "buildnumber": 2513, 21:19:21 INFO - "slavename": "talos-linux64-ix-025", 21:19:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:19:21 INFO - "platform": "ubuntu64_hw", 21:19:21 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:19:21 INFO - "branch": "mozilla-inbound", 21:19:21 INFO - "repo_path": "integration/mozilla-inbound", 21:19:21 INFO - "revision": "c8b0d217e5a4a903975eb2a104a3fb5e56899e6f", 21:19:21 INFO - "stage_platform": "linux64-pgo", 21:19:21 INFO - "builduid": "b5afcdc88cf946ad832c2e737f6c2074", 21:19:21 INFO - "slavebuilddir": "test" 21:19:21 INFO - } 21:19:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:19:21 INFO - Running post-action listener: _resource_record_post_action 21:19:21 INFO - [mozharness: 2016-10-01 04:19:21.812646Z] Finished read-buildbot-config step (success) 21:19:21 INFO - [mozharness: 2016-10-01 04:19:21.812736Z] Running download-and-extract step. 21:19:21 INFO - Running pre-action listener: _resource_record_pre_action 21:19:21 INFO - Running main action method: download_and_extract 21:19:21 INFO - mkdir: /builds/slave/test/build/tests 21:19: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')]} 21:19:21 INFO - trying https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:19:21 INFO - Downloading https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:19:22 INFO - Downloaded 1361 bytes. 21:19:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:19:22 INFO - Using the following test package requirements: 21:19:22 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:22 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:19:22 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:19:22 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:22 INFO - u'jsshell-linux-x86_64.zip'], 21:19:22 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:19:22 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:22 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:19:22 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:19:22 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:19:22 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:19:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:19:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:19:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:19:22 INFO - Fetch https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:19:22 INFO - Http code: 200 21:19:22 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 21:19:22 INFO - x-amz-cf-id: MzFfyFzPj2mnaTiKHSQ1kAWSfjGQ0BKO_Oow-a3j0tGADMwU33IijA== 21:19:22 INFO - x-amz-version-id: yViFCEAZjlO8109Uelu8CNJ0hN31Hf2H 21:19:23 INFO - Expected file size: 21991366 21:19:23 INFO - Obtained file size: 21991366 21:19:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:19:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:19:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:19:27 INFO - Fetch https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:19:27 INFO - Http code: 200 21:19:27 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 21:19:27 INFO - x-amz-cf-id: VcG1DziD2oB1WTJ0AWf8qT8WE8SDUkITEz2heDGAeGoEj2bu0qI09w== 21:19:27 INFO - x-amz-version-id: yViFCEAZjlO8109Uelu8CNJ0hN31Hf2H 21:19:28 INFO - Expected file size: 21991366 21:19:28 INFO - Obtained file size: 21991366 21:19:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:19:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:19:32 INFO - Fetch https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:19:33 INFO - Http code: 200 21:19:33 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 21:19:33 INFO - x-amz-cf-id: um3i2yf-K8PGChI0az-cpYbFWNl-DJRH9Eb8cg4uzoL_ub6P24aJbw== 21:19:33 INFO - x-amz-version-id: i124aktxvTEGJpf57iYv7.9iLrjXCMX9 21:19:33 INFO - Expected file size: 14408522 21:19:33 INFO - Obtained file size: 14408522 21:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:33 INFO - trying https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:19:33 INFO - Downloading https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:19:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:19:34 INFO - Downloaded 59717128 bytes. 21:19:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:19:34 INFO - mkdir: /builds/slave/test/properties 21:19:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:19:34 INFO - Writing to file /builds/slave/test/properties/build_url 21:19:34 INFO - Contents: 21:19:34 INFO - build_url:https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:19:35 INFO - Running post-action listener: _resource_record_post_action 21:19:35 INFO - Running post-action listener: set_extra_try_arguments 21:19:35 INFO - [mozharness: 2016-10-01 04:19:35.460300Z] Finished download-and-extract step (success) 21:19:35 INFO - [mozharness: 2016-10-01 04:19:35.460528Z] Running populate-webroot step. 21:19:35 INFO - Running pre-action listener: _resource_record_pre_action 21:19:35 INFO - Running main action method: populate_webroot 21:19:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:19:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:19:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:19:35 INFO - '--tppagecycles', 21:19:35 INFO - '7'], 21:19:35 INFO - 'tests': ['tsvgm']}}, 21:19:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:19:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:19:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:19:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:19:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:35 INFO - 'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:19:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:19:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:35 INFO - 'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['damp', 'tps']}, 21:19:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:35 INFO - 'tests': ['damp', 'tps']}, 21:19:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['dromaeo_dom']}, 21:19:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:19:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['basic_compositor_video']}, 21:19:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:19:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['a11yr', 21:19:35 INFO - 'ts_paint', 21:19:35 INFO - 'tpaint', 21:19:35 INFO - 'sessionrestore', 21:19:35 INFO - 'sessionrestore_no_auto_restore', 21:19:35 INFO - 'tabpaint']}, 21:19:35 INFO - 'other-e10s': {'tests': ['a11yr', 21:19:35 INFO - 'ts_paint', 21:19:35 INFO - 'tpaint', 21:19:35 INFO - 'sessionrestore', 21:19:35 INFO - 'sessionrestore_no_auto_restore', 21:19:35 INFO - 'tabpaint']}, 21:19:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:19:35 INFO - 'ts_paint', 21:19:35 INFO - 'tpaint', 21:19:35 INFO - 'sessionrestore', 21:19:35 INFO - 'sessionrestore_no_auto_restore', 21:19:35 INFO - 'tabpaint']}, 21:19:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:19:35 INFO - 'ts_paint', 21:19:35 INFO - 'tpaint', 21:19:35 INFO - 'sessionrestore', 21:19:35 INFO - 'sessionrestore_no_auto_restore', 21:19:35 INFO - 'tabpaint']}, 21:19:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['a11yr', 21:19:35 INFO - 'ts_paint', 21:19:35 INFO - 'tpaint', 21:19:35 INFO - 'sessionrestore', 21:19:35 INFO - 'sessionrestore_no_auto_restore', 21:19:35 INFO - 'tabpaint']}, 21:19:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['a11yr', 21:19:35 INFO - 'ts_paint', 21:19:35 INFO - 'tpaint', 21:19:35 INFO - 'sessionrestore', 21:19:35 INFO - 'sessionrestore_no_auto_restore', 21:19:35 INFO - 'tabpaint']}, 21:19:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['tsvgx', 21:19:35 INFO - 'tsvgr_opacity', 21:19:35 INFO - 'tart', 21:19:35 INFO - 'tscrollx', 21:19:35 INFO - 'cart']}, 21:19:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:19:35 INFO - 'tsvgr_opacity', 21:19:35 INFO - 'tart', 21:19:35 INFO - 'tscrollx', 21:19:35 INFO - 'cart']}, 21:19:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:35 INFO - 'talos_options': ['--disable-e10s'], 21:19:35 INFO - 'tests': ['tp5o']}, 21:19:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:35 INFO - 'tests': ['tp5o']}, 21:19:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:35 INFO - 'talos_options': ['--disable-e10s', 21:19:35 INFO - '--xperf_path', 21:19:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:19:35 INFO - 'tests': ['tp5n']}, 21:19:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:35 INFO - 'talos_options': ['--xperf_path', 21:19:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:19:35 INFO - 'tests': ['tp5n']}}, 21:19:35 INFO - 'talos.zip': {'path': '', 21:19:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:19:35 INFO - Running post-action listener: _resource_record_post_action 21:19:35 INFO - [mozharness: 2016-10-01 04:19:35.481990Z] Finished populate-webroot step (success) 21:19:35 INFO - [mozharness: 2016-10-01 04:19:35.482079Z] Running create-virtualenv step. 21:19:35 INFO - Running pre-action listener: _resource_record_pre_action 21:19:35 INFO - Running main action method: create_virtualenv 21:19:35 INFO - Creating virtualenv /builds/slave/test/build/venv 21:19:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:19:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:19:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:19:35 INFO - Using real prefix '/usr' 21:19:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:19:36 INFO - Installing distribute.............................................................................................................................................................................................done. 21:19:38 INFO - Installing pip.................done. 21:19:38 INFO - Return code: 0 21:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:19:38 INFO - Reading from file tmpfile_stdout 21:19:38 INFO - Output received: 21:19:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:19:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ba0731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, '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': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:19:38 INFO - Using env: {'DISPLAY': ':0', 21:19:38 INFO - 'HOME': '/home/cltbld', 21:19:38 INFO - 'LANG': 'en_US.UTF-8', 21:19:38 INFO - 'LANGUAGE': 'en_US:en', 21:19:38 INFO - 'LOGNAME': 'cltbld', 21:19:38 INFO - 'MAIL': '/var/mail/cltbld', 21:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:38 INFO - 'MOZ_NO_REMOTE': '1', 21:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:38 INFO - 'NO_EM_RESTART': '1', 21:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:38 INFO - 'PWD': '/builds/slave/test', 21:19:38 INFO - 'SHELL': '/bin/bash', 21:19:38 INFO - 'SHLVL': '1', 21:19:38 INFO - 'TERM': 'linux', 21:19:38 INFO - 'TMOUT': '86400', 21:19:38 INFO - 'USER': 'cltbld', 21:19:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:38 INFO - '_': '/tools/buildbot/bin/python'} 21:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:19:38 INFO - Cleaning up... 21:19:38 INFO - Return code: 0 21:19:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5ba0731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, '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': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:19:38 INFO - Using env: {'DISPLAY': ':0', 21:19:38 INFO - 'HOME': '/home/cltbld', 21:19:38 INFO - 'LANG': 'en_US.UTF-8', 21:19:38 INFO - 'LANGUAGE': 'en_US:en', 21:19:38 INFO - 'LOGNAME': 'cltbld', 21:19:38 INFO - 'MAIL': '/var/mail/cltbld', 21:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:38 INFO - 'MOZ_NO_REMOTE': '1', 21:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:38 INFO - 'NO_EM_RESTART': '1', 21:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:38 INFO - 'PWD': '/builds/slave/test', 21:19:38 INFO - 'SHELL': '/bin/bash', 21:19:38 INFO - 'SHLVL': '1', 21:19:38 INFO - 'TERM': 'linux', 21:19:38 INFO - 'TMOUT': '86400', 21:19:38 INFO - 'USER': 'cltbld', 21:19:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:38 INFO - '_': '/tools/buildbot/bin/python'} 21:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:38 INFO - Downloading/unpacking psutil>=3.1.1 21:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:19:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:19:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:19:40 INFO - Installing collected packages: psutil 21:19:40 INFO - Running setup.py install for psutil 21:19:40 INFO - building 'psutil._psutil_linux' extension 21:19:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:19:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:19:40 INFO - building 'psutil._psutil_posix' extension 21:19:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:19:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:19:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:19:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:19:41 INFO - Successfully installed psutil 21:19:41 INFO - Cleaning up... 21:19:41 INFO - Return code: 0 21:19:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:19: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')]} 21:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19: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')]} 21:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:41 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 0x7f5ba0731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, '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': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:19:41 INFO - Using env: {'DISPLAY': ':0', 21:19:41 INFO - 'HOME': '/home/cltbld', 21:19:41 INFO - 'LANG': 'en_US.UTF-8', 21:19:41 INFO - 'LANGUAGE': 'en_US:en', 21:19:41 INFO - 'LOGNAME': 'cltbld', 21:19:41 INFO - 'MAIL': '/var/mail/cltbld', 21:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:41 INFO - 'MOZ_NO_REMOTE': '1', 21:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:41 INFO - 'NO_EM_RESTART': '1', 21:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:41 INFO - 'PWD': '/builds/slave/test', 21:19:41 INFO - 'SHELL': '/bin/bash', 21:19:41 INFO - 'SHLVL': '1', 21:19:41 INFO - 'TERM': 'linux', 21:19:41 INFO - 'TMOUT': '86400', 21:19:41 INFO - 'USER': 'cltbld', 21:19:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:41 INFO - '_': '/tools/buildbot/bin/python'} 21:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:19:43 INFO - Installing collected packages: mozsystemmonitor 21:19:43 INFO - Running setup.py install for mozsystemmonitor 21:19:43 INFO - Successfully installed mozsystemmonitor 21:19:43 INFO - Cleaning up... 21:19:43 INFO - Return code: 0 21:19:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ba0731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, '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': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:19:43 INFO - Using env: {'DISPLAY': ':0', 21:19:43 INFO - 'HOME': '/home/cltbld', 21:19:43 INFO - 'LANG': 'en_US.UTF-8', 21:19:43 INFO - 'LANGUAGE': 'en_US:en', 21:19:43 INFO - 'LOGNAME': 'cltbld', 21:19:43 INFO - 'MAIL': '/var/mail/cltbld', 21:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:43 INFO - 'MOZ_NO_REMOTE': '1', 21:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:43 INFO - 'NO_EM_RESTART': '1', 21:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:43 INFO - 'PWD': '/builds/slave/test', 21:19:43 INFO - 'SHELL': '/bin/bash', 21:19:43 INFO - 'SHLVL': '1', 21:19:43 INFO - 'TERM': 'linux', 21:19:43 INFO - 'TMOUT': '86400', 21:19:43 INFO - 'USER': 'cltbld', 21:19:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:43 INFO - '_': '/tools/buildbot/bin/python'} 21:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:43 INFO - Downloading/unpacking jsonschema==2.5.1 21:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:19:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:45 INFO - Downloading functools32-3.2.3-2.tar.gz 21:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:19:45 INFO - warning: no files found matching '*.txt' 21:19:45 INFO - no previously-included directories found matching 'build' 21:19:45 INFO - no previously-included directories found matching 'dist' 21:19:45 INFO - no previously-included directories found matching '.git*' 21:19:45 INFO - Installing collected packages: jsonschema, functools32 21:19:45 INFO - Running setup.py install for functools32 21:19:46 INFO - warning: no files found matching '*.txt' 21:19:46 INFO - no previously-included directories found matching 'build' 21:19:46 INFO - no previously-included directories found matching 'dist' 21:19:46 INFO - no previously-included directories found matching '.git*' 21:19:46 INFO - Successfully installed jsonschema functools32 21:19:46 INFO - Cleaning up... 21:19:46 INFO - Return code: 0 21:19:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:46 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 0x7f5ba0731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, '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': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:19:46 INFO - Using env: {'DISPLAY': ':0', 21:19:46 INFO - 'HOME': '/home/cltbld', 21:19:46 INFO - 'LANG': 'en_US.UTF-8', 21:19:46 INFO - 'LANGUAGE': 'en_US:en', 21:19:46 INFO - 'LOGNAME': 'cltbld', 21:19:46 INFO - 'MAIL': '/var/mail/cltbld', 21:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:46 INFO - 'MOZ_NO_REMOTE': '1', 21:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:46 INFO - 'NO_EM_RESTART': '1', 21:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:46 INFO - 'PWD': '/builds/slave/test', 21:19:46 INFO - 'SHELL': '/bin/bash', 21:19:46 INFO - 'SHLVL': '1', 21:19:46 INFO - 'TERM': 'linux', 21:19:46 INFO - 'TMOUT': '86400', 21:19:46 INFO - 'USER': 'cltbld', 21:19:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:46 INFO - '_': '/tools/buildbot/bin/python'} 21:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:19:46 INFO - Cleaning up... 21:19:46 INFO - Return code: 0 21:19:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:46 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 0x7f5ba0731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, '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': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:19:46 INFO - Using env: {'DISPLAY': ':0', 21:19:46 INFO - 'HOME': '/home/cltbld', 21:19:46 INFO - 'LANG': 'en_US.UTF-8', 21:19:46 INFO - 'LANGUAGE': 'en_US:en', 21:19:46 INFO - 'LOGNAME': 'cltbld', 21:19:46 INFO - 'MAIL': '/var/mail/cltbld', 21:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:46 INFO - 'MOZ_NO_REMOTE': '1', 21:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:46 INFO - 'NO_EM_RESTART': '1', 21:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:46 INFO - 'PWD': '/builds/slave/test', 21:19:46 INFO - 'SHELL': '/bin/bash', 21:19:46 INFO - 'SHLVL': '1', 21:19:46 INFO - 'TERM': 'linux', 21:19:46 INFO - 'TMOUT': '86400', 21:19:46 INFO - 'USER': 'cltbld', 21:19:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:46 INFO - '_': '/tools/buildbot/bin/python'} 21:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:46 INFO - Downloading/unpacking blobuploader==1.2.4 21:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:48 INFO - Downloading blobuploader-1.2.4.tar.gz 21:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:19:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:19:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:49 INFO - Downloading docopt-0.6.1.tar.gz 21:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:19:49 INFO - Installing collected packages: blobuploader, requests, docopt 21:19:49 INFO - Running setup.py install for blobuploader 21:19:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:19:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:19:49 INFO - Running setup.py install for requests 21:19:49 INFO - Running setup.py install for docopt 21:19:49 INFO - Successfully installed blobuploader requests docopt 21:19:49 INFO - Cleaning up... 21:19:49 INFO - Return code: 0 21:19:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:49 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 0x7f5ba0731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, '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': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:19:49 INFO - Using env: {'DISPLAY': ':0', 21:19:49 INFO - 'HOME': '/home/cltbld', 21:19:49 INFO - 'LANG': 'en_US.UTF-8', 21:19:49 INFO - 'LANGUAGE': 'en_US:en', 21:19:49 INFO - 'LOGNAME': 'cltbld', 21:19:49 INFO - 'MAIL': '/var/mail/cltbld', 21:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:49 INFO - 'MOZ_NO_REMOTE': '1', 21:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:49 INFO - 'NO_EM_RESTART': '1', 21:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:49 INFO - 'PWD': '/builds/slave/test', 21:19:49 INFO - 'SHELL': '/bin/bash', 21:19:49 INFO - 'SHLVL': '1', 21:19:49 INFO - 'TERM': 'linux', 21:19:49 INFO - 'TMOUT': '86400', 21:19:49 INFO - 'USER': 'cltbld', 21:19:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:49 INFO - '_': '/tools/buildbot/bin/python'} 21:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:19:50 INFO - Running setup.py (path:/tmp/pip-AhTTzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:19:50 INFO - Running setup.py (path:/tmp/pip-hyxWvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:19:50 INFO - Running setup.py (path:/tmp/pip-aBt3Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:19:50 INFO - Running setup.py (path:/tmp/pip-Souswn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:19:50 INFO - Running setup.py (path:/tmp/pip-U1loUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:19:50 INFO - Running setup.py (path:/tmp/pip-Jtj38a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:19:50 INFO - Running setup.py (path:/tmp/pip-CXVj8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:19:50 INFO - Running setup.py (path:/tmp/pip-aMSb6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:19:50 INFO - Running setup.py (path:/tmp/pip-bStuME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:19:50 INFO - Running setup.py (path:/tmp/pip-tmBg7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:19:50 INFO - Running setup.py (path:/tmp/pip-UfCY8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:19:50 INFO - Running setup.py (path:/tmp/pip-PjiFzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:19:50 INFO - Running setup.py (path:/tmp/pip-q1qxK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:19:50 INFO - Running setup.py (path:/tmp/pip-39Dsh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:19:51 INFO - Running setup.py (path:/tmp/pip-LTLMu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:19:51 INFO - Running setup.py (path:/tmp/pip-07t1pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:19:51 INFO - Running setup.py (path:/tmp/pip-Tl7G96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:19:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:19:51 INFO - Running setup.py install for manifestparser 21:19:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:19:51 INFO - Running setup.py install for mozcrash 21:19:51 INFO - Running setup.py install for mozdebug 21:19:51 INFO - Running setup.py install for mozdevice 21:19:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:19:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:19:51 INFO - Running setup.py install for mozfile 21:19:51 INFO - Running setup.py install for mozhttpd 21:19:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:19:51 INFO - Running setup.py install for mozinfo 21:19:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:19:51 INFO - Running setup.py install for mozInstall 21:19:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:19:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:19:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:19:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:19:52 INFO - Running setup.py install for mozleak 21:19:52 INFO - Running setup.py install for mozlog 21:19:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:19:52 INFO - Running setup.py install for moznetwork 21:19:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:19:52 INFO - Running setup.py install for mozprocess 21:19:52 INFO - Running setup.py install for mozprofile 21:19:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:19:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:19:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:19:52 INFO - Running setup.py install for mozrunner 21:19:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:19:52 INFO - Running setup.py install for mozscreenshot 21:19:52 INFO - Running setup.py install for moztest 21:19:52 INFO - Running setup.py install for mozversion 21:19:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:19:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:19:53 INFO - Cleaning up... 21:19:53 INFO - Return code: 0 21:19:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:53 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 0x7f5ba0731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, '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': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:19:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:19:53 INFO - Using env: {'DISPLAY': ':0', 21:19:53 INFO - 'HOME': '/home/cltbld', 21:19:53 INFO - 'LANG': 'en_US.UTF-8', 21:19:53 INFO - 'LANGUAGE': 'en_US:en', 21:19:53 INFO - 'LOGNAME': 'cltbld', 21:19:53 INFO - 'MAIL': '/var/mail/cltbld', 21:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:53 INFO - 'MOZ_NO_REMOTE': '1', 21:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:53 INFO - 'NO_EM_RESTART': '1', 21:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:53 INFO - 'PWD': '/builds/slave/test', 21:19:53 INFO - 'SHELL': '/bin/bash', 21:19:53 INFO - 'SHLVL': '1', 21:19:53 INFO - 'TERM': 'linux', 21:19:53 INFO - 'TMOUT': '86400', 21:19:53 INFO - 'USER': 'cltbld', 21:19:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:53 INFO - '_': '/tools/buildbot/bin/python'} 21:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:19:53 INFO - Running setup.py (path:/tmp/pip-duq_CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:19:53 INFO - Running setup.py (path:/tmp/pip-jFhP_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:19:53 INFO - Running setup.py (path:/tmp/pip-ypiKbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:19:53 INFO - Running setup.py (path:/tmp/pip-xRoMdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:19:53 INFO - Running setup.py (path:/tmp/pip-JmkQ1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:19:53 INFO - Running setup.py (path:/tmp/pip-7ohokI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:19:53 INFO - Running setup.py (path:/tmp/pip-16KPAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:19:53 INFO - Running setup.py (path:/tmp/pip-9LUj0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:19:53 INFO - Running setup.py (path:/tmp/pip-oq0jDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:19:53 INFO - Running setup.py (path:/tmp/pip-Gj4CAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:19:54 INFO - Running setup.py (path:/tmp/pip-V9VbPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:19:54 INFO - Running setup.py (path:/tmp/pip-txpqES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:19:54 INFO - Running setup.py (path:/tmp/pip-ARPbxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:19:54 INFO - Running setup.py (path:/tmp/pip-UZ1_y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:19:54 INFO - Running setup.py (path:/tmp/pip-uUzyNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:19:54 INFO - Running setup.py (path:/tmp/pip-qoK4vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:19:54 INFO - Running setup.py (path:/tmp/pip-Ie8ltH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:19:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:56 INFO - Downloading blessings-1.6.tar.gz 21:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:19:56 INFO - Installing collected packages: blessings 21:19:56 INFO - Running setup.py install for blessings 21:19:56 INFO - Successfully installed blessings 21:19:56 INFO - Cleaning up... 21:19:56 INFO - Return code: 0 21:19:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:19:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:19:56 INFO - Reading from file tmpfile_stdout 21:19:56 INFO - Current package versions: 21:19:56 INFO - argparse == 1.2.1 21:19:56 INFO - blessings == 1.6 21:19:56 INFO - blobuploader == 1.2.4 21:19:56 INFO - docopt == 0.6.1 21:19:56 INFO - functools32 == 3.2.3-2 21:19:56 INFO - jsonschema == 2.5.1 21:19:56 INFO - manifestparser == 1.1 21:19:56 INFO - mozInstall == 1.12 21:19:56 INFO - mozcrash == 0.17 21:19:56 INFO - mozdebug == 0.1 21:19:56 INFO - mozdevice == 0.48 21:19:56 INFO - mozfile == 1.2 21:19:56 INFO - mozhttpd == 0.7 21:19:56 INFO - mozinfo == 0.9 21:19:56 INFO - mozleak == 0.1 21:19:56 INFO - mozlog == 3.4 21:19:56 INFO - moznetwork == 0.27 21:19:56 INFO - mozprocess == 0.23 21:19:56 INFO - mozprofile == 0.28 21:19:56 INFO - mozrunner == 6.12 21:19:56 INFO - mozscreenshot == 0.1 21:19:56 INFO - mozsystemmonitor == 0.3 21:19:56 INFO - moztest == 0.7 21:19:56 INFO - mozversion == 1.4 21:19:56 INFO - psutil == 3.1.1 21:19:56 INFO - requests == 1.2.3 21:19:56 INFO - wsgiref == 0.1.2 21:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:56 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 0x7f5ba0731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, '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': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:19:56 INFO - Using env: {'DISPLAY': ':0', 21:19:56 INFO - 'HOME': '/home/cltbld', 21:19:56 INFO - 'LANG': 'en_US.UTF-8', 21:19:56 INFO - 'LANGUAGE': 'en_US:en', 21:19:56 INFO - 'LOGNAME': 'cltbld', 21:19:56 INFO - 'MAIL': '/var/mail/cltbld', 21:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:56 INFO - 'MOZ_NO_REMOTE': '1', 21:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:56 INFO - 'NO_EM_RESTART': '1', 21:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:56 INFO - 'PWD': '/builds/slave/test', 21:19:56 INFO - 'SHELL': '/bin/bash', 21:19:56 INFO - 'SHLVL': '1', 21:19:56 INFO - 'TERM': 'linux', 21:19:56 INFO - 'TMOUT': '86400', 21:19:56 INFO - 'USER': 'cltbld', 21:19:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:56 INFO - '_': '/tools/buildbot/bin/python'} 21:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:19:57 INFO - Cleaning up... 21:19:57 INFO - Return code: 0 21:19:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:57 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 0x7f5ba0731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, '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': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:19:57 INFO - Using env: {'DISPLAY': ':0', 21:19:57 INFO - 'HOME': '/home/cltbld', 21:19:57 INFO - 'LANG': 'en_US.UTF-8', 21:19:57 INFO - 'LANGUAGE': 'en_US:en', 21:19:57 INFO - 'LOGNAME': 'cltbld', 21:19:57 INFO - 'MAIL': '/var/mail/cltbld', 21:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:57 INFO - 'MOZ_NO_REMOTE': '1', 21:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:57 INFO - 'NO_EM_RESTART': '1', 21:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:57 INFO - 'PWD': '/builds/slave/test', 21:19:57 INFO - 'SHELL': '/bin/bash', 21:19:57 INFO - 'SHLVL': '1', 21:19:57 INFO - 'TERM': 'linux', 21:19:57 INFO - 'TMOUT': '86400', 21:19:57 INFO - 'USER': 'cltbld', 21:19:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:57 INFO - '_': '/tools/buildbot/bin/python'} 21:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:19:57 INFO - Cleaning up... 21:19:57 INFO - Return code: 0 21:19:57 INFO - Running post-action listener: _resource_record_post_action 21:19:57 INFO - Running post-action listener: _start_resource_monitoring 21:19:57 INFO - Starting resource monitoring. 21:19:57 INFO - [mozharness: 2016-10-01 04:19:57.390205Z] Finished create-virtualenv step (success) 21:19:57 INFO - [mozharness: 2016-10-01 04:19:57.390671Z] Running install step. 21:19:57 INFO - Running pre-action listener: _resource_record_pre_action 21:19:57 INFO - Running main action method: install 21:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:19:57 INFO - Reading from file tmpfile_stdout 21:19:57 INFO - Detecting whether we're running mozinstall >=1.0... 21:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:19:57 INFO - Reading from file tmpfile_stdout 21:19:57 INFO - Output received: 21:19:57 INFO - Usage: mozinstall [options] installer 21:19:57 INFO - Options: 21:19:57 INFO - -h, --help show this help message and exit 21:19:57 INFO - -d DEST, --destination=DEST 21:19:57 INFO - Directory to install application into. [default: 21:19:57 INFO - "/builds/slave/test"] 21:19:57 INFO - --app=APP Application being installed. [default: firefox] 21:19:57 INFO - mkdir: /builds/slave/test/build/application 21:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:20:15 INFO - Reading from file tmpfile_stdout 21:20:15 INFO - Output received: 21:20:15 INFO - /builds/slave/test/build/application/firefox/firefox 21:20:15 INFO - Running post-action listener: _resource_record_post_action 21:20:15 INFO - [mozharness: 2016-10-01 04:20:15.331633Z] Finished install step (success) 21:20:15 INFO - [mozharness: 2016-10-01 04:20:15.331880Z] Running run-tests step. 21:20:15 INFO - Running pre-action listener: _resource_record_pre_action 21:20:15 INFO - Running main action method: run_tests 21:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:20:15 INFO - Python 2.7.3 21:20:15 INFO - Return code: 0 21:20:15 INFO - grabbing minidump binary from tooltool 21:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:20:15 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 0x1d6af60>, '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 0x1d6bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:20:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:20:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:20:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:20:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:20:15 INFO - Return code: 0 21:20:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:20:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:20:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:20:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:20:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:20:15 INFO - Using env: {'DISPLAY': ':0', 21:20:15 INFO - 'HOME': '/home/cltbld', 21:20:15 INFO - 'LANG': 'en_US.UTF-8', 21:20:15 INFO - 'LANGUAGE': 'en_US:en', 21:20:15 INFO - 'LOGNAME': 'cltbld', 21:20:15 INFO - 'MAIL': '/var/mail/cltbld', 21:20:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:20:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:15 INFO - 'MOZ_NO_REMOTE': '1', 21:20:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:15 INFO - 'NO_EM_RESTART': '1', 21:20:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:15 INFO - 'PWD': '/builds/slave/test', 21:20:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:20:15 INFO - 'SHELL': '/bin/bash', 21:20:15 INFO - 'SHLVL': '1', 21:20:15 INFO - 'TERM': 'linux', 21:20:15 INFO - 'TMOUT': '86400', 21:20:15 INFO - 'USER': 'cltbld', 21:20:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543', 21:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:15 INFO - '_': '/tools/buildbot/bin/python'} 21:20:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:20:15 INFO - mozversion application_buildid: 20160930183005 21:20:15 INFO - mozversion application_changeset: c8b0d217e5a4a903975eb2a104a3fb5e56899e6f 21:20:15 INFO - mozversion application_display_name: Nightly 21:20:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:20:15 INFO - mozversion application_name: Firefox 21:20:15 INFO - mozversion application_remotingname: firefox 21:20:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:20:15 INFO - mozversion application_vendor: Mozilla 21:20:15 INFO - mozversion application_version: 52.0a1 21:20:15 INFO - mozversion platform_buildid: 20160930183005 21:20:15 INFO - mozversion platform_changeset: c8b0d217e5a4a903975eb2a104a3fb5e56899e6f 21:20:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:20:15 INFO - mozversion platform_version: 52.0a1 21:20:15 INFO - using testdate: 1475295615 21:20:15 INFO - actual date: 1475295615 21:20:15 INFO - starting webserver on 'localhost:36826' 21:20:15 INFO - SUITE-START | Running 2 tests 21:20:15 INFO - TEST-START | dromaeo_css 21:20:15 INFO - operating with platform_type : linux_ 21:20:15 INFO - Initialising browser for dromaeo_css test... 21:20:15 INFO - TEST-INFO | started process 27741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmAhUJt/profile http://localhost:36826/getInfo.html) 21:20:20 INFO - PROCESS | 27741 | __metrics Screen width/height:1600/1200 21:20:20 INFO - PROCESS | 27741 | colorDepth:24 21:20:20 INFO - PROCESS | 27741 | Browser inner width/height: 1024/697 21:20:20 INFO - PROCESS | 27741 | __metrics 21:20:20 INFO - PROCESS | 27741 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:20:20 INFO - PROCESS | 27741 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:20:21 INFO - PROCESS | 27741 | console.error: PushService: 21:20:21 INFO - PROCESS | 27741 | stateChangeProcessEnqueue: Error transitioning state 21:20:21 INFO - PROCESS | 27741 | UnknownError 21:20:21 INFO - TEST-INFO | 27741: exit 0 21:20:21 INFO - Browser initialized. 21:20:21 INFO - Running cycle 1/1 for dromaeo_css test... 21:20:21 INFO - TEST-INFO | started process 27823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmAhUJt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:20:33 INFO - PROCESS | 27823 | RSS: Main: 174063616 21:20:33 INFO - PROCESS | 27823 | 21:21:25 INFO - PROCESS | 27823 | 1475295685220 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:23:35 INFO - PROCESS | 27823 | Cycle 1(1): loaded http://localhost:36826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36826/tests/dromaeo/cssquery-ext.html) 21:23:36 INFO - PROCESS | 27823 | RSS: Main: 282603520 21:23:36 INFO - PROCESS | 27823 | 21:26:39 INFO - PROCESS | 27823 | Cycle 1(1): loaded http://localhost:36826/tests/dromaeo/cssquery-ext.html (next: http://localhost:36826/tests/dromaeo/cssquery-jquery.html) 21:26:39 INFO - PROCESS | 27823 | RSS: Main: 275075072 21:26:39 INFO - PROCESS | 27823 | 21:29:41 INFO - PROCESS | 27823 | Cycle 1(1): loaded http://localhost:36826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36826/tests/dromaeo/cssquery-mootools.html) 21:29:42 INFO - PROCESS | 27823 | RSS: Main: 215646208 21:29:42 INFO - PROCESS | 27823 | 21:32:44 INFO - PROCESS | 27823 | Cycle 1(1): loaded http://localhost:36826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36826/tests/dromaeo/cssquery-prototype.html) 21:32:44 INFO - PROCESS | 27823 | RSS: Main: 213712896 21:32:44 INFO - PROCESS | 27823 | 21:35:47 INFO - PROCESS | 27823 | Cycle 1(1): loaded http://localhost:36826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36826/tests/dromaeo/cssquery-yui.html) 21:35:48 INFO - PROCESS | 27823 | RSS: Main: 213778432 21:35:48 INFO - PROCESS | 27823 | 21:38:51 INFO - PROCESS | 27823 | Cycle 1(1): loaded http://localhost:36826/tests/dromaeo/cssquery-yui.html (next: http://localhost:36826/tests/dromaeo/cssquery-dojo.html) 21:38:51 INFO - PROCESS | 27823 | RSS: Main: 307023872 21:38:51 INFO - PROCESS | 27823 | 21:38:51 INFO - PROCESS | 27823 | __start_tp_report 21:38:51 INFO - PROCESS | 27823 | _x_x_mozilla_page_load 21:38:51 INFO - PROCESS | 27823 | _x_x_mozilla_page_load_details 21:38:51 INFO - PROCESS | 27823 | |i|pagename|runs| 21:38:51 INFO - PROCESS | 27823 | |0;dojo.html;2930.750886174675;2955.187323486041;2960.363521842804;2978.568107624393;3002.534607135893;4992.226204938241;5052.545270925616;5052.974735126324;5132.21361961066;5132.384113906332;5089.567386772129;5090.847274581768;5103.617228707843;5122.282880396738;5183.092958732216;4742.19382704941;4751.16854550454;4752.952470475286;4777.641676874231;4788.784504697297;4777.474477807438;4822.614190864722;4826.975865120687;4833.178359678863;4871.658983871131;4676.766161691919;4802.97598512007;4902.215645496722;4904;4904.411470623512;4665.206914824488;4798.688085274446;4822.276658501235;4847;4847.466778654345;4623.398958135454;4635.582797548237;4677;4689.953100468986;4698.271767875985;5082.390113186404;5161.251618515332;5166.7416629168765;5175.327207463043;5224.8693782655355;5497.47773961473;5527.2538207342295;5527.50252477275;5531.806386776484;5539.556835453154;5301.60237982149;5339.6262261641705;5521.171824226398;5606.579506537026;5629.493345598916;5234.293370394986;5241.554467870274;5243.79024839006;5248.737563121828;5252.107141785906;5726.885462290814;5732.3121225453215;5740.540756739534;5741.981750290611;5805.535557155417;5319.494648008433;5369.033573956725;5382.407935127133;5431.891362172734;5441.700706461183;5528.889422211533;5534.667919924817;5534.916976245359;5538.584606154554;5599.076152434803;5511.724413779295;5512;5520.779168833202;5524.254225679562;5526.806561770319;5218.634695571273;5239.214117882349;5296.4968328009545;5367.490088441592;5596.748146333425;4220.873373798791;4225.19721252961;4225.260579398654;4225.535191128974;4298.290782020931;3839.788811615388;3888.922221555553;3921;3937.468441760383;3976.4631774710624;5276.604254680914;5290.312259406252;5290.576753859682;5293.311869456946;5343.572514198855;5449.264349312792;5575.414581468887;5631.2960879890015;5642.125470552071;5646.153077038395;5156.123459011977;5192.7403629818355;5270.472952704698;5273.762680679379;5274.894502109936;4840.685355451885;4851.054044461367;4851.102546028996;4854;4904.092742842586;5493.2034854946605;5701.030824759718;5708.771649133988;5714.028615135437;5718.542516598662;5336.0661884170895;5499.642523235977;5543.750531226024;5543.916841247304;5641.689707066151;5682.8579285516535;5720;5731.054376027909;5735.13972904051;5735.741891614971;5482.39693633692;5483.506484416422;5484.1773733938635;5485.890282194414;5490.149026900836;5455.8363249101;5457.808976685797;5508.118701007819;5508.807191748269;5535.446455354432;5413.215083812904;5419.485148910847;5423.403425623257;5424.810131645373;5477.4248703887115;5339.893202136013;5386.326709161355;5390.97304513475;5397.379301380392;5463.562914966714;5246.842594722164;5277.736113194402;5306.893862122659;5315.255864178941;5358.7320633967365;5481.945180548143;5487.560995120461;5495.313085864267;5527.143292789624;5546.833594991996;5311.787528498817;5374.973125134349;5377.24718539397;5379.542738867083;5433.701146436984 21:38:51 INFO - PROCESS | 27823 | |1;ext.html;583.3408248678992;605.9757609695611;620.5004970998344;622.2439735721098;631.6525910749087;33050.50424243635;45229;45979;46005.53994460058;46088;43459;43894.780526097325;43906.56093439065;43953;43970.34044489335;8174.26431621154;8931.106889311066;9090.227330676867;9094.408863423889;9100.180983711465;8110.675572977103;8416.158384161596;8421.073681894986;10729.409882456463;10913.345199288067;11063;11105.278156919814;11120.55517779292;11126.443677816118;11126.721831954184;10890.782184356309;10949.781004379947;10965.780684386267;10969.945150274278;10975.83536246957;10751.462426878625;10792.190585706103;10809.945950270278;10823;10829.187810914213;41192.38211426831;41469.37795933063;41561.79219103915;41567.584324156676;41663.7916810414;3123.5470856725647;3443.8450269737923;3454.240067185215;3515.1739341254784;3688.188598508324;30612.846935765403;30805.38389232203;31567.84216078905;31576;31670;4292.678049146327;4411.713238639478;4422.579854913778;4434.11317736454;4480.910381792379;330604;332102;333517;333790;333842.99999999756;50872.745636272324;51139.232911506355;51166.48833511617;51180;51183.23225151626;57714.13428798571;58311.70844145837;58495.70752146297;58518;58519;14690.926545367418;14872.925635371754;14873.47942821996;14873.70252594942;14876.92561537207;12148.45331960064;12158.5136594537;12186;12186.878131218751;12186.878131218751;13592;13819.239941803096;13844.030917835655;14302.57092287233;14329.35517901697;5674.290713660793;6268.341824108494;6273.247210334789;6445.937300064028;6731.562448440934;930.15356026016;977.7338346840858;1006.9345492542961;1027.814993301198;1113.777244551093;28945.85527072351;29103.708962910525;29135.41729165405;29710.257243569085;29956.400871982438;1060.745421098946;1095.222392101601;1101.1081024370285;1102.4377567440663;1204.9215951723158;15208.543743687485;15709.842901570839;15995.760063599055;16039.713402277566;16112.597185070466;476610;480026;480082;480650;481911;48425.273620895714;53118;53954;54260.728696356266;54474.727626361615;1284.9678758030936;1291.877271659191;1297.6593295426783;1317.1636011132807;1324.668832791802;29046.7095329044;30531.2367190822;30865.382692345578;30983.845080774452;31010.209081182802;46858.76570617125;47178.29232561583;47197.76401117972;47311;47464.2880356788;413703;415001;416122;416508;416743;32328;32498.512522312656;32591.837040814644;32596.34807303888;32752.34495310128;44728.32907506325;44848.10303793971;44902;45352.54647453615;45852.39516616902;37689.43465847959;38043.048923777125;39090;39592.40611390774;40027;38203.617963820005;38372.040698982746;38723.806380967915;39587.80206098951;40686.38970415505;36729.44905826468;37150.44274335833;37158.8142059288;37336.81331593324;37364.43953340757;33256.50115248225;35039.299214016086;35161.47257791084;35634.82182589071;36188;24301.27096187117;24619.19925614488;24659.383515412257;25040.123595674064;25112.748872511773 21:38:51 INFO - PROCESS | 27823 | |2;jquery.html;375.24201113750206;382.3213795512966;392.54856914548265;397.64013567721213;420.6109348852311;13243.45371361822;15279.541613751577;16631.916840415783;19418.126184321703;19636.70544941827;17407.912960435213;17637;17896.91051544744;17912.28350865967;19241;5707.1153971134545;5954.404559544054;5962.642241465526;5964.642121472725;5965.433283838029;5560.888782224353;5838.941610583904;5869.941300587004;5872.324682661484;5872.853178670546;5587.245721827562;5828.941710582903;5829.183914252008;5836.941630583682;5838.095095260221;5744;5755.223044888929;5780.50865676418;5799.652020878761;5807.767689292423;4979.875503112415;5145.691258524501;5194.662346947474;5194.870128246786;5198.324217851655;23306.76693233063;23338.766612333828;23365.41586460352;23475.295741127793;23524.64713029306;2315.0392587076344;2353.364591560286;2354.882255887199;2356.363781778927;2438.878056097206;14031.508897188549;14346.42614295427;14816.697565935021;14937.626559335995;15038.924805376013;1825.790034146077;1900.4108726294892;1938.4959910423252;1992.85053620979;1997.1412292714126;71831;75235;76071.61964190198;84229;87460.12539874583;9811.920688724234;10369;10883.346999179916;11002.284851484628;11102.500387482422;15103.169325687193;15229.314680839389;15286.923565382325;15440.845591544165;15464.613384665474;7674.42441816866;7747.883781743279;7842.29419352261;7963.920360796434;8178;7381.963090184515;7403.777886663409;7499.512531685423;7691.807704807425;7720.3437707795465;4183.205191013698;4192.790360482025;4543.863684089482;4625.930611040837;4686.625069994392;1826.8081851405411;1870.3173341730171;1892.1201641236892;1909.8376637985648;1948.4544327588299;896.825119101782;971.2181693736469;988.7083310423299;994.9452780097164;999.0509016434416;17248.827511724972;19139.97090916357;19161.520961975784;19162.329318473785;19247.711284330748;978.88072323419;1001.4592120254981;1018.4856647393167;1022.483645758887;1058.2697938422464;9753.21974242059;10082.29423940317;10861.83707244392;10872.61945831892;10880.619178328721;476170;477305;478320;493117;493591;92843;96424.51787741156;96572;98330;100877;961.6057416459358;1013.8783345998528;1018.4653057145058;1033.607229252879;1049.034887903131;16245.10651914156;16362.263698133374;16591;16884.662306754042;16990;40782.1843563133;40799.38800917929;41078.38382424326;41347.379789303784;42531;56027.71986140043;56200.156997645885;56463.71768141133;57546.42453575578;58792.70603646954;7516.661750221362;7893.329067029367;8015.83968320642;8123.75628731139;8280.089190188954;12439.129260952008;12632.305223212812;12907.741845163231;13022.218666880017;13064.34678266102;10911.618093367011;11047.116230701364;11363.48864301125;11809.704757381134;12072.939635301767;11251.943740281245;11291.717707057389;11391.202615816814;11398.772024559628;11624.966397514749;11015.449227538431;11246.156538259827;11420.143489238175;11777.411129443322;11970.042396608076;7067.399271062018;7336.889946650697;7366.742164024234;7402;7858.803529911798;10364;10805.675829725122;10817.675469735921;11171.553137874394;12187.51249949992 21:38:51 INFO - PROCESS | 27823 | |3;mootools.html;1341.9800951277027;1448.0298200205862;1483.3325003748312;1608.1637548474794;1759.9824001759987;7626.923730762691;8685.435446695968;8950.149735775107;8965.10348965104;9165.037671044543;8866.468011919289;8956.686515971942;8991.820163596723;9030.277577793777;9055.094490550959;2244.865308081512;2266.7279926408773;2268.8298377621663;2274.6133157363206;2277.3054218463362;2221.3224966385246;2247.6291411917096;2293.289080385086;2296.4144143243448;2299.31020693792;2242.237639202671;2278.8063014643694;2293.575688497625;2321.535692861426;2324.8023917966993;2186.1583290433296;2198.8900554972265;2201.2515744646817;2201.6037113319517;2208.569328980849;2140.636091864387;2182.0617134632103;2185.093186327688;2194.418479103039;2194.440417693494;8617.870731939025;8694.478331300079;8702.956485217534;8707.69523066696;8891.510966896818;5207.453217412193;5301.602379821529;5310.176922577007;5315.176147697113;5340.279062326575;3313.436715758327;3356.4126277901514;3386.407378708741;3396.677315655009;3397.2630106882234;1023.447338437243;1036.8341065429495;1040.9011143941314;1053.8840727519967;1094.3543309447384;12351.752964940652;12369.443375048144;12372.81440778389;12455.314957677325;12468.251904885736;4086.7547947123267;4138.296489596776;4271.786410679453;4304.117655880537;4331.97834010828;9637.4217546946;9672.903270967341;9698.515074246401;9701.51492425376;9718.514074296398;5076.13705670037;5092.388913330424;5094.363204599425;5095.592352611782;5114.207297868837;4154.875353739392;4227.830886764556;4245.087306229114;4357.498887627963;4763.404574428197;3449.5688038995127;3782.167923056923;3785.905352366213;3795.9051023724073;3808.980955095207;1070.4380200394698;1122.15277465513;1125.5947858770999;1126.2510430563584;1129.7796929598815;864.8875646165958;868.8653258744905;899.9910000900038;917.1791246834047;938.5307346326837;5636.464535869086;5670.092785154438;5720.885582288331;5854.443827836349;5941.792037278761;950.6340059077305;964.4840010594298;968.2254196642798;974.171953839231;988.421773262635;3791.9241615167543;3948.1511475033008;4013.337799263089;4044.9797751011056;4129.710920235615;11141.554337826557;11314.264572802742;11460.541578336773;11469.197156198987;11506.88493115075;11228.831567526493;11318.717032074099;11334.319940803578;11354;11364.318140911571;8123.837523249502;8299.336053115736;8303.833923321621;8321.916780832235;8323;5253.50091741284;5492.231087647812;5547.33431988164;5584.636998595079;5616.719164041863;10041.899581004096;10099.444530550596;10184.032516910882;10188.337758045704;10375.066244038073;9354.859677104985;9908.207343412365;10262.640807571699;10455.797583277716;10538.683839484827;6740.258571557027;7183.20984691694;7319.634018298957;7387.741429049957;7530.774076777706;8317.625706843328;8353.498790072616;8370;8525.147485251673;8650.524221167896;7769.92230077692;7887.211278872067;7888.132305446511;7905.486143400891;7944.602769861368;7565.962170189114;7666.923330766844;7719.807004824925;7722.382209423345;7827.412944029106;6574.408303252731;6751.93248067513;6816.897746533707;6860.862782744417;6959.304069593;5019.146745053423;5122.334096567422;5148.3564554430695;5155.407128180307;5171.276021357088;5029.119904016856;5067.265246539305;5071.721055341992;5147.305113809588;5224.52979231871 21:38:51 INFO - PROCESS | 27823 | |4;prototype.html;307.3054895935187;317.1105050333813;317.94435973704594;318.85810814187687;322.71600991127804;5218.869528261791;5218.921716174261;5251.501107394796;5251.921221181676;5291.735413229338;5142.537171654551;5154.871128221796;5178.0161769263905;5210.739463026843;5211.088059589576;3811.4473401356786;3922.607739226083;3977.3835055566433;4029.153877685675;4056.3104272273786;4050.9797451012705;4060.127072679373;4060.8984775380704;4072.6131017553435;4079.265732168223;4029.899252518696;4030.407988844405;4032.3749818777987;4039.485193052605;4052.5744796796207;3801.7909015004166;3834.5015148030716;3951.269015232177;4022.3765316376007;4051.1087560736887;3555.6977656899194;3587.228745819635;3587.3542762302777;3593.2094939113354;3593.2993066352074;5075.847724568269;5091;5108.489151084899;5127.230915362688;5157.252198431206;4516.36770852081;4591.1965406053805;4620.861374158781;4633.49031606523;4696.084263568571;5355.143177091685;5383.273258110184;5404.189371594253;5412.0516614018925;5425.294711687495;3906.199229158016;3906.2031465525893;3920.7843568603716;3927.6465118139504;3936.822842972073;5282.392524859613;5487.890242195133;5587.776488940438;5624.831255062355;5626.352969408488;3896.8636097736444;3917.6278253565865;3919.3729003359895;3925.371940489508;3951.5060617422823;3968.900777480586;3986.661133803659;3993.740406873544;4006.23881462527;4029.6171863672903;4506.504284528699;4526.456825181;4621.168189725814;4634.72191668501;4636.768161591907;5408.891822163535;5417.295751552273;5427.348718153847;5491.842190740261;5493.890122197534;1354.6342487528311;1372.3275594958398;1376.3324787478066;1383.986160138406;1388.2156581531403;837.3468694418364;885.5041176940933;889.5996801439248;894.5169608411516;901.4230892228978;5050.848474545696;5078.5937125029905;5161.690298582097;5247.134222853263;5280.498352656491;5577.693226872561;5584.357798853102;5587.832365029056;5589.552835773128;5601.151619965402;5118.667286626357;5253.894922101613;5270.077736396115;5274.815381461631;5285.048691235537;2903;2953.852307384665;2957.8521073946217;2958.3343747656604;2959.0974752700204;5718.712514993953;5726.79956201531;5758.157389635277;5767.163761254595;5777.497850558885;5464.617476776667;5660.2075709400715;5663.377028526858;5673.347565030074;5676.403977582377;5705.286839145107;5718.942810572007;5733.168690539848;5740.847182306635;5754.654720716687;5357;5567.077284425709;5588.3573389060775;5626.24045753818;5633.6619802811965;5469.863253418696;5497.257870187634;5504.91742623869;5524.4199359066715;5543.36251331086;5699.971500142473;5729.2265544151005;5734.627249228787;5791;5817.738201780845;3706.9183575286893;3849.9230015400094;3860.4209368594934;3862.5364956205435;3889.9416508752956;5600.8879822402505;5602.047651899268;5607.8878422432135;5620.85947851307;5649.435056494318;5424;5443.700596467233;5446.428125046971;5462.371827239918;5501.422350653123;5192.1952097424955;5456.399796022355;5471.398146203994;5471.972640136773;5509.834704958857;5433.945660543344;5435.701036442875;5448.400675925565;5452.5365343946205;5460.863478413072;5273.551748101454;5281.920771188358;5409.891802163856;5472.753726082256;5551.9722401387735;5347.491988261109;5349.491798279158;5409.810656626999;5410.269613602113;5419 21:38:51 INFO - PROCESS | 27823 | |5;yui.html;557.2727590494409;592.706610227937;682.290417965316;717.8012718759674;796.8127490039841;13901.930490347546;14801.777973330409;14966.401343946229;14990.400383984655;15024;13545.187288762681;13561.593152205425;13573.932130339359;13626.727465450685;13627.591172264823;634.3529599808193;652.5953908576689;747.6448686873719;755.4522970846134;765.12775436003;757.7120694136221;757.8029712274821;759.8594260061878;761.090496856257;764.1174443517746;805.7260531419316;806.6773290683744;806.6894245715383;806.8709006558952;807.5800583696474;666.8032930285553;682.4608559238196;793.0443815202725;802.7551596762985;810.9716159934374;594.3818428834007;595.8718875441757;595.8867815115115;596.4631831351775;596.704631207555;13852.099613525088;13892.305384730724;13990.930045349809;13997.5100871469;14002.019858609901;13393.397297121654;13663.931680341633;13801.309934503335;13873.722525549534;14179.64550886236;12379.319137447437;12498;12559.372031398394;12686.64135037872;12700.364981750876;4228.513720922103;4233.745975241495;4289.463817022872;4293.978530107361;4300.784960751981;76694.1739151986;77211;77496;77973.22026779717;79054.60472697657;10568;10856.402897840537;10928.617498387677;11062.557497700163;11090.778184436265;20146.496337591678;20162.29431969874;20162.495937601678;20270.79729202689;20298.89850550738;7501.062367204099;7526.059242594676;7679.19368466303;7696.846063078707;7856.960715196502;4345.087531618332;4356.542563030836;4508.120916421266;4544.409226800561;4650.558196971282;3142.1987393214586;3210.7431405487505;3220.8872689455757;3241.0438920518504;3249.6587858275016;596.2874365133624;597.208698474523;599.4155698194313;605.9424354686298;623.1027320658328;472.4826315184867;596.7105953612495;613.3896772711091;614.7233744814852;621.8134559632092;8005.319547838382;8409.201125893152;8469.915300847037;8527.573621318908;8591.140885911358;606.6542071019477;612.7242740766673;620.3517324396017;622.9750809967551;643.9156440649331;3994.2610617035944;4098.508179018537;4136.110736191733;4148.834046638161;4327.6105150536605;120040.39979800045;122250;122774.24741639296;124307.41112314176;127756.36121819331;98317;98522.50738746261;99300;102623.4868825651;102884;89084.55457722669;91074;95100.52449737846;96085;96720;7877.448578599443;7921.722739704313;8269.857454167377;8275.9586202071;8551.529665868187;40782.388264176654;44561;45207.32189017101;49002;56745.43254567401;71113.64443177752;72161.63919180371;72492.63753681198;73803.26196738178;75893;11171.497282622464;11434.428278586203;11529.135314851588;11680.357580332824;11722.648320550397;13573.253471059186;13662.56543062964;13760.724785504433;13767;14064.859351406354;11798.351090690094;12087.697807554881;12433.502659893504;12507.56223532172;12571;12650.00324871689;12764;12913.612591622266;13195.67010824737;13311.267880266678;11379.601713939972;11719.76560468803;11867.940660296988;12144.757104857677;12199.817002745143;10160.898391015995;10279.94860025695;10293.279470437297;10515.684529464128;10567.78864422692;8880.333974951775;10502;11168.832467512831;11212.327260364404;11307.321560706385 21:38:51 INFO - PROCESS | 27823 | __end_tp_report 21:38:51 INFO - PROCESS | 27823 | __start_cc_report 21:38:51 INFO - PROCESS | 27823 | _x_x_mozilla_cycle_collect,1068 21:38:51 INFO - PROCESS | 27823 | __end_cc_report 21:38:51 INFO - PROCESS | 27823 | __startTimestamp1475296731334__endTimestamp 21:38:51 INFO - PROCESS | 27823 | 21:38:51 INFO - PROCESS | 27823 | ------- Summary: start ------- 21:38:51 INFO - PROCESS | 27823 | Number of tests: 6 21:38:51 INFO - PROCESS | 27823 | 21:38:51 INFO - PROCESS | 27823 | [#0] dojo.html Cycles:165 Average:5152.34 Median:5315.26 stddev:567.40 (10.7%) stddev-sans-first:541.72 21:38:51 INFO - PROCESS | 27823 | Values: 2930.8 2955.2 2960.4 2978.6 3002.5 4992.2 5052.5 5053.0 5132.2 5132.4 5089.6 5090.8 5103.6 5122.3 5183.1 4742.2 4751.2 4753.0 4777.6 4788.8 4777.5 4822.6 4827.0 4833.2 4871.7 4676.8 4803.0 4902.2 4904.0 4904.4 4665.2 4798.7 4822.3 4847.0 4847.5 4623.4 4635.6 4677.0 4690.0 4698.3 5082.4 5161.3 5166.7 5175.3 5224.9 5497.5 5527.3 5527.5 5531.8 5539.6 5301.6 5339.6 5521.2 5606.6 5629.5 5234.3 5241.6 5243.8 5248.7 5252.1 5726.9 5732.3 5740.5 5742.0 5805.5 5319.5 5369.0 5382.4 5431.9 5441.7 5528.9 5534.7 5534.9 5538.6 5599.1 5511.7 5512.0 5520.8 5524.3 5526.8 5218.6 5239.2 5296.5 5367.5 5596.7 4220.9 4225.2 4225.3 4225.5 4298.3 3839.8 3888.9 3921.0 3937.5 3976.5 5276.6 5290.3 5290.6 5293.3 5343.6 5449.3 5575.4 5631.3 5642.1 5646.2 5156.1 5192.7 5270.5 5273.8 5274.9 4840.7 4851.1 4851.1 4854.0 4904.1 5493.2 5701.0 5708.8 5714.0 5718.5 5336.1 5499.6 5543.8 5543.9 5641.7 5682.9 5720.0 5731.1 5735.1 5735.7 5482.4 5483.5 5484.2 5485.9 5490.1 5455.8 5457.8 5508.1 5508.8 5535.4 5413.2 5419.5 5423.4 5424.8 5477.4 5339.9 5386.3 5391.0 5397.4 5463.6 5246.8 5277.7 5306.9 5315.3 5358.7 5481.9 5487.6 5495.3 5527.1 5546.8 5311.8 5375.0 5377.2 5379.5 5433.7 21:38:51 INFO - PROCESS | 27823 | 21:38:51 INFO - PROCESS | 27823 | [#1] ext.html Cycles:180 Average:56557.98 Median:20208.82 stddev:109431.35 (541.5%) stddev-sans-first:109657.63 21:38:51 INFO - PROCESS | 27823 | Values: 583.3 606.0 620.5 622.2 631.7 33050.5 45229.0 45979.0 46005.5 46088.0 43459.0 43894.8 43906.6 43953.0 43970.3 8174.3 8931.1 9090.2 9094.4 9100.2 8110.7 8416.2 8421.1 10729.4 10913.3 11063.0 11105.3 11120.6 11126.4 11126.7 10890.8 10949.8 10965.8 10969.9 10975.8 10751.5 10792.2 10809.9 10823.0 10829.2 41192.4 41469.4 41561.8 41567.6 41663.8 3123.5 3443.8 3454.2 3515.2 3688.2 30612.8 30805.4 31567.8 31576.0 31670.0 4292.7 4411.7 4422.6 4434.1 4480.9 330604.0 332102.0 333517.0 333790.0 333843.0 50872.7 51139.2 51166.5 51180.0 51183.2 57714.1 58311.7 58495.7 58518.0 58519.0 14690.9 14872.9 14873.5 14873.7 14876.9 12148.5 12158.5 12186.0 12186.9 12186.9 13592.0 13819.2 13844.0 14302.6 14329.4 5674.3 6268.3 6273.2 6445.9 6731.6 930.2 977.7 1006.9 1027.8 1113.8 28945.9 29103.7 29135.4 29710.3 29956.4 1060.7 1095.2 1101.1 1102.4 1204.9 15208.5 15709.8 15995.8 16039.7 16112.6 476610.0 480026.0 480082.0 480650.0 481911.0 48425.3 53118.0 53954.0 54260.7 54474.7 1285.0 1291.9 1297.7 1317.2 1324.7 29046.7 30531.2 30865.4 30983.8 31010.2 46858.8 47178.3 47197.8 47311.0 47464.3 413703.0 415001.0 416122.0 416508.0 416743.0 32328.0 32498.5 32591.8 32596.3 32752.3 44728.3 44848.1 44902.0 45352.5 45852.4 37689.4 38043.0 39090.0 39592.4 40027.0 38203.6 38372.0 38723.8 39587.8 40686.4 36729.4 37150.4 37158.8 37336.8 37364.4 33256.5 35039.3 35161.5 35634.8 36188.0 24301.3 24619.2 24659.4 25040.1 25112.7 21:38:51 INFO - PROCESS | 27823 | 21:38:51 INFO - PROCESS | 27823 | [#2] jquery.html Cycles:180 Average:28726.66 Median:2397.62 stddev:79899.73 (3332.5%) stddev-sans-first:80095.52 21:38:51 INFO - PROCESS | 27823 | Values: 375.2 382.3 392.5 397.6 420.6 13243.5 15279.5 16631.9 19418.1 19636.7 17407.9 17637.0 17896.9 17912.3 19241.0 5707.1 5954.4 5962.6 5964.6 5965.4 5560.9 5838.9 5869.9 5872.3 5872.9 5587.2 5828.9 5829.2 5836.9 5838.1 5744.0 5755.2 5780.5 5799.7 5807.8 4979.9 5145.7 5194.7 5194.9 5198.3 23306.8 23338.8 23365.4 23475.3 23524.6 2315.0 2353.4 2354.9 2356.4 2438.9 14031.5 14346.4 14816.7 14937.6 15038.9 1825.8 1900.4 1938.5 1992.9 1997.1 71831.0 75235.0 76071.6 84229.0 87460.1 9811.9 10369.0 10883.3 11002.3 11102.5 15103.2 15229.3 15286.9 15440.8 15464.6 7674.4 7747.9 7842.3 7963.9 8178.0 7382.0 7403.8 7499.5 7691.8 7720.3 4183.2 4192.8 4543.9 4625.9 4686.6 1826.8 1870.3 1892.1 1909.8 1948.5 896.8 971.2 988.7 994.9 999.1 17248.8 19140.0 19161.5 19162.3 19247.7 978.9 1001.5 1018.5 1022.5 1058.3 9753.2 10082.3 10861.8 10872.6 10880.6 476170.0 477305.0 478320.0 493117.0 493591.0 92843.0 96424.5 96572.0 98330.0 100877.0 961.6 1013.9 1018.5 1033.6 1049.0 16245.1 16362.3 16591.0 16884.7 16990.0 40782.2 40799.4 41078.4 41347.4 42531.0 56027.7 56200.2 56463.7 57546.4 58792.7 7516.7 7893.3 8015.8 8123.8 8280.1 12439.1 12632.3 12907.7 13022.2 13064.3 10911.6 11047.1 11363.5 11809.7 12072.9 11251.9 11291.7 11391.2 11398.8 11625.0 11015.4 11246.2 11420.1 11777.4 11970.0 7067.4 7336.9 7366.7 7402.0 7858.8 10364.0 10805.7 10817.7 11171.6 12187.5 21:38:51 INFO - PROCESS | 27823 | 21:38:51 INFO - PROCESS | 27823 | [#3] mootools.html Cycles:180 Average:5724.54 Median:5069.49 stddev:3354.83 (66.2%) stddev-sans-first:3348.07 21:38:51 INFO - PROCESS | 27823 | Values: 1342.0 1448.0 1483.3 1608.2 1760.0 7626.9 8685.4 8950.1 8965.1 9165.0 8866.5 8956.7 8991.8 9030.3 9055.1 2244.9 2266.7 2268.8 2274.6 2277.3 2221.3 2247.6 2293.3 2296.4 2299.3 2242.2 2278.8 2293.6 2321.5 2324.8 2186.2 2198.9 2201.3 2201.6 2208.6 2140.6 2182.1 2185.1 2194.4 2194.4 8617.9 8694.5 8703.0 8707.7 8891.5 5207.5 5301.6 5310.2 5315.2 5340.3 3313.4 3356.4 3386.4 3396.7 3397.3 1023.4 1036.8 1040.9 1053.9 1094.4 12351.8 12369.4 12372.8 12455.3 12468.3 4086.8 4138.3 4271.8 4304.1 4332.0 9637.4 9672.9 9698.5 9701.5 9718.5 5076.1 5092.4 5094.4 5095.6 5114.2 4154.9 4227.8 4245.1 4357.5 4763.4 3449.6 3782.2 3785.9 3795.9 3809.0 1070.4 1122.2 1125.6 1126.3 1129.8 864.9 868.9 900.0 917.2 938.5 5636.5 5670.1 5720.9 5854.4 5941.8 950.6 964.5 968.2 974.2 988.4 3791.9 3948.2 4013.3 4045.0 4129.7 11141.6 11314.3 11460.5 11469.2 11506.9 11228.8 11318.7 11334.3 11354.0 11364.3 8123.8 8299.3 8303.8 8321.9 8323.0 5253.5 5492.2 5547.3 5584.6 5616.7 10041.9 10099.4 10184.0 10188.3 10375.1 9354.9 9908.2 10262.6 10455.8 10538.7 6740.3 7183.2 7319.6 7387.7 7530.8 8317.6 8353.5 8370.0 8525.1 8650.5 7769.9 7887.2 7888.1 7905.5 7944.6 7566.0 7666.9 7719.8 7722.4 7827.4 6574.4 6751.9 6816.9 6860.9 6959.3 5019.1 5122.3 5148.4 5155.4 5171.3 5029.1 5067.3 5071.7 5147.3 5224.5 21:38:51 INFO - PROCESS | 27823 | 21:38:51 INFO - PROCESS | 27823 | [#4] prototype.html Cycles:180 Average:4569.74 Median:5261.99 stddev:1355.81 (25.8%) stddev-sans-first:1321.33 21:38:51 INFO - PROCESS | 27823 | Values: 307.3 317.1 317.9 318.9 322.7 5218.9 5218.9 5251.5 5251.9 5291.7 5142.5 5154.9 5178.0 5210.7 5211.1 3811.4 3922.6 3977.4 4029.2 4056.3 4051.0 4060.1 4060.9 4072.6 4079.3 4029.9 4030.4 4032.4 4039.5 4052.6 3801.8 3834.5 3951.3 4022.4 4051.1 3555.7 3587.2 3587.4 3593.2 3593.3 5075.8 5091.0 5108.5 5127.2 5157.3 4516.4 4591.2 4620.9 4633.5 4696.1 5355.1 5383.3 5404.2 5412.1 5425.3 3906.2 3906.2 3920.8 3927.6 3936.8 5282.4 5487.9 5587.8 5624.8 5626.4 3896.9 3917.6 3919.4 3925.4 3951.5 3968.9 3986.7 3993.7 4006.2 4029.6 4506.5 4526.5 4621.2 4634.7 4636.8 5408.9 5417.3 5427.3 5491.8 5493.9 1354.6 1372.3 1376.3 1384.0 1388.2 837.3 885.5 889.6 894.5 901.4 5050.8 5078.6 5161.7 5247.1 5280.5 5577.7 5584.4 5587.8 5589.6 5601.2 5118.7 5253.9 5270.1 5274.8 5285.0 2903.0 2953.9 2957.9 2958.3 2959.1 5718.7 5726.8 5758.2 5767.2 5777.5 5464.6 5660.2 5663.4 5673.3 5676.4 5705.3 5718.9 5733.2 5740.8 5754.7 5357.0 5567.1 5588.4 5626.2 5633.7 5469.9 5497.3 5504.9 5524.4 5543.4 5700.0 5729.2 5734.6 5791.0 5817.7 3706.9 3849.9 3860.4 3862.5 3889.9 5600.9 5602.0 5607.9 5620.9 5649.4 5424.0 5443.7 5446.4 5462.4 5501.4 5192.2 5456.4 5471.4 5472.0 5509.8 5433.9 5435.7 5448.4 5452.5 5460.9 5273.6 5281.9 5409.9 5472.8 5552.0 5347.5 5349.5 5409.8 5410.3 5419.0 21:38:51 INFO - PROCESS | 27823 | 21:38:51 INFO - PROCESS | 27823 | [#5] yui.html Cycles:180 Average:20692.60 Median:4314.20 stddev:31290.92 (725.3%) stddev-sans-first:31342.18 21:38:51 INFO - PROCESS | 27823 | Values: 557.3 592.7 682.3 717.8 796.8 13901.9 14801.8 14966.4 14990.4 15024.0 13545.2 13561.6 13573.9 13626.7 13627.6 634.4 652.6 747.6 755.5 765.1 757.7 757.8 759.9 761.1 764.1 805.7 806.7 806.7 806.9 807.6 666.8 682.5 793.0 802.8 811.0 594.4 595.9 595.9 596.5 596.7 13852.1 13892.3 13990.9 13997.5 14002.0 13393.4 13663.9 13801.3 13873.7 14179.6 12379.3 12498.0 12559.4 12686.6 12700.4 4228.5 4233.7 4289.5 4294.0 4300.8 76694.2 77211.0 77496.0 77973.2 79054.6 10568.0 10856.4 10928.6 11062.6 11090.8 20146.5 20162.3 20162.5 20270.8 20298.9 7501.1 7526.1 7679.2 7696.8 7857.0 4345.1 4356.5 4508.1 4544.4 4650.6 3142.2 3210.7 3220.9 3241.0 3249.7 596.3 597.2 599.4 605.9 623.1 472.5 596.7 613.4 614.7 621.8 8005.3 8409.2 8469.9 8527.6 8591.1 606.7 612.7 620.4 623.0 643.9 3994.3 4098.5 4136.1 4148.8 4327.6 120040.4 122250.0 122774.2 124307.4 127756.4 98317.0 98522.5 99300.0 102623.5 102884.0 89084.6 91074.0 95100.5 96085.0 96720.0 7877.4 7921.7 8269.9 8276.0 8551.5 40782.4 44561.0 45207.3 49002.0 56745.4 71113.6 72161.6 72492.6 73803.3 75893.0 11171.5 11434.4 11529.1 11680.4 11722.6 13573.3 13662.6 13760.7 13767.0 14064.9 11798.4 12087.7 12433.5 12507.6 12571.0 12650.0 12764.0 12913.6 13195.7 13311.3 11379.6 11719.8 11867.9 12144.8 12199.8 10160.9 10279.9 10293.3 10515.7 10567.8 8880.3 10502.0 11168.8 11212.3 11307.3 21:38:51 INFO - PROCESS | 27823 | -------- Summary: end -------- 21:38:51 INFO - PROCESS | 27823 | 21:38:52 INFO - TEST-INFO | 27823: exit 0 21:38:52 INFO - TEST-OK | dromaeo_css | took 1116674ms 21:38:52 INFO - TEST-START | kraken 21:38:52 INFO - operating with platform_type : linux_ 21:38:52 INFO - Initialising browser for kraken test... 21:38:52 INFO - TEST-INFO | started process 28128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB3NcdA/profile http://localhost:36826/getInfo.html) 21:38:56 INFO - PROCESS | 28128 | __metrics Screen width/height:1600/1200 21:38:56 INFO - PROCESS | 28128 | colorDepth:24 21:38:56 INFO - PROCESS | 28128 | Browser inner width/height: 1024/697 21:38:56 INFO - PROCESS | 28128 | __metrics 21:38:57 INFO - PROCESS | 28128 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:38:57 INFO - PROCESS | 28128 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:38:57 INFO - PROCESS | 28128 | console.error: PushService: 21:38:57 INFO - PROCESS | 28128 | stateChangeProcessEnqueue: Error transitioning state 21:38:57 INFO - PROCESS | 28128 | UnknownError 21:38:58 INFO - TEST-INFO | 28128: exit 0 21:38:58 INFO - Browser initialized. 21:38:58 INFO - Running cycle 1/1 for kraken test... 21:38:58 INFO - TEST-INFO | started process 28213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB3NcdA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:10 INFO - PROCESS | 28213 | RSS: Main: 173125632 21:39:10 INFO - PROCESS | 28213 | 21:39:13 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36826/tests/kraken/driver.html?testName=audio-beat-detection) 21:39:13 INFO - PROCESS | 28213 | RSS: Main: 232603648 21:39:13 INFO - PROCESS | 28213 | 21:39:16 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36826/tests/kraken/driver.html?testName=audio-dft) 21:39:17 INFO - PROCESS | 28213 | RSS: Main: 217235456 21:39:17 INFO - PROCESS | 28213 | 21:39:20 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36826/tests/kraken/driver.html?testName=audio-fft) 21:39:20 INFO - PROCESS | 28213 | RSS: Main: 298577920 21:39:20 INFO - PROCESS | 28213 | 21:39:23 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36826/tests/kraken/driver.html?testName=audio-oscillator) 21:39:23 INFO - PROCESS | 28213 | RSS: Main: 208277504 21:39:23 INFO - PROCESS | 28213 | 21:39:25 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:39:26 INFO - PROCESS | 28213 | RSS: Main: 212566016 21:39:26 INFO - PROCESS | 28213 | 21:39:29 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36826/tests/kraken/driver.html?testName=imaging-darkroom) 21:39:29 INFO - PROCESS | 28213 | RSS: Main: 249401344 21:39:29 INFO - PROCESS | 28213 | 21:39:33 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36826/tests/kraken/driver.html?testName=imaging-desaturate) 21:39:34 INFO - PROCESS | 28213 | RSS: Main: 247803904 21:39:34 INFO - PROCESS | 28213 | 21:39:36 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36826/tests/kraken/driver.html?testName=json-parse-financial) 21:39:37 INFO - PROCESS | 28213 | RSS: Main: 247611392 21:39:37 INFO - PROCESS | 28213 | 21:39:38 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:39:39 INFO - PROCESS | 28213 | RSS: Main: 210137088 21:39:39 INFO - PROCESS | 28213 | 21:39:41 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36826/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:39:41 INFO - PROCESS | 28213 | RSS: Main: 217149440 21:39:41 INFO - PROCESS | 28213 | 21:39:43 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:39:44 INFO - PROCESS | 28213 | RSS: Main: 222347264 21:39:44 INFO - PROCESS | 28213 | 21:39:47 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:39:47 INFO - PROCESS | 28213 | RSS: Main: 223924224 21:39:47 INFO - PROCESS | 28213 | 21:39:50 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:39:51 INFO - PROCESS | 28213 | RSS: Main: 221462528 21:39:51 INFO - PROCESS | 28213 | 21:39:52 INFO - PROCESS | 28213 | Cycle 1(1): loaded http://localhost:36826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36826/tests/kraken/driver.html?testName=ai-astar) 21:39:53 INFO - PROCESS | 28213 | RSS: Main: 272977920 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | __start_tp_report 21:39:53 INFO - PROCESS | 28213 | _x_x_mozilla_page_load 21:39:53 INFO - PROCESS | 28213 | _x_x_mozilla_page_load_details 21:39:53 INFO - PROCESS | 28213 | |i|pagename|runs| 21:39:53 INFO - PROCESS | 28213 | |0;ai-astar;109;110;110;112;112;110;110;111;111;112 21:39:53 INFO - PROCESS | 28213 | |1;audio-beat-detection;155;126;122;154;124;127;123;121;154;123 21:39:53 INFO - PROCESS | 28213 | |2;audio-dft;161;162;162;173;163;162;162;162;161;163 21:39:53 INFO - PROCESS | 28213 | |3;audio-fft;74;75;76;111;76;75;77;76;97;74 21:39:53 INFO - PROCESS | 28213 | |4;audio-oscillator;82;82;105;82;83;83;101;83;83;114 21:39:53 INFO - PROCESS | 28213 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;116;116 21:39:53 INFO - PROCESS | 28213 | |6;imaging-darkroom;146;147;147;146;147;147;146;146;147;146 21:39:53 INFO - PROCESS | 28213 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 21:39:53 INFO - PROCESS | 28213 | |8;json-parse-financial;53;54;52;53;54;52;53;52;53;53 21:39:53 INFO - PROCESS | 28213 | |9;json-stringify-tinderbox;61;61;61;60;61;62;61;61;61;62 21:39:53 INFO - PROCESS | 28213 | |10;stanford-crypto-aes;86;80;79;79;85;79;79;87;78;78 21:39:53 INFO - PROCESS | 28213 | |11;stanford-crypto-ccm;135;138;139;138;129;141;150;132;170;133 21:39:53 INFO - PROCESS | 28213 | |12;stanford-crypto-pbkdf2;168;169;166;168;173;168;168;166;168;169 21:39:53 INFO - PROCESS | 28213 | |13;stanford-crypto-sha256-iterative;67;66;68;68;66;67;70;66;69;66 21:39:53 INFO - PROCESS | 28213 | __end_tp_report 21:39:53 INFO - PROCESS | 28213 | __start_cc_report 21:39:53 INFO - PROCESS | 28213 | _x_x_mozilla_cycle_collect,1649 21:39:53 INFO - PROCESS | 28213 | __end_cc_report 21:39:53 INFO - PROCESS | 28213 | __startTimestamp1475296793245__endTimestamp 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | ------- Summary: start ------- 21:39:53 INFO - PROCESS | 28213 | Number of tests: 14 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.06 (1.0%) stddev-sans-first:0.93 21:39:53 INFO - PROCESS | 28213 | Values: 109.0 110.0 110.0 112.0 112.0 110.0 110.0 111.0 111.0 112.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:126.50 stddev:14.90 (11.8%) stddev-sans-first:13.48 21:39:53 INFO - PROCESS | 28213 | Values: 155.0 126.0 122.0 154.0 124.0 127.0 123.0 121.0 154.0 123.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.00 stddev:3.54 (2.2%) stddev-sans-first:3.67 21:39:53 INFO - PROCESS | 28213 | Values: 161.0 162.0 162.0 173.0 163.0 162.0 162.0 162.0 161.0 163.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:12.55 (16.5%) stddev-sans-first:13.04 21:39:53 INFO - PROCESS | 28213 | Values: 74.0 75.0 76.0 111.0 76.0 75.0 77.0 76.0 97.0 74.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:82.50 stddev:12.06 (14.6%) stddev-sans-first:12.46 21:39:53 INFO - PROCESS | 28213 | Values: 82.0 82.0 105.0 82.0 83.0 83.0 101.0 83.0 83.0 114.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:39:53 INFO - PROCESS | 28213 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:39:53 INFO - PROCESS | 28213 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 21:39:53 INFO - PROCESS | 28213 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 21:39:53 INFO - PROCESS | 28213 | Values: 53.0 54.0 52.0 53.0 54.0 52.0 53.0 52.0 53.0 53.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 21:39:53 INFO - PROCESS | 28213 | Values: 61.0 61.0 61.0 60.0 61.0 62.0 61.0 61.0 61.0 62.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:79.50 stddev:3.53 (4.4%) stddev-sans-first:3.24 21:39:53 INFO - PROCESS | 28213 | Values: 86.0 80.0 79.0 79.0 85.0 79.0 79.0 87.0 78.0 78.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:138.50 stddev:11.86 (8.6%) stddev-sans-first:12.41 21:39:53 INFO - PROCESS | 28213 | Values: 135.0 138.0 139.0 138.0 129.0 141.0 150.0 132.0 170.0 133.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.00 stddev:1.95 (1.2%) stddev-sans-first:2.06 21:39:53 INFO - PROCESS | 28213 | Values: 168.0 169.0 166.0 168.0 173.0 168.0 168.0 166.0 168.0 169.0 21:39:53 INFO - PROCESS | 28213 | 21:39:53 INFO - PROCESS | 28213 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.42 (2.1%) stddev-sans-first:1.50 21:39:53 INFO - PROCESS | 28213 | Values: 67.0 66.0 68.0 68.0 66.0 67.0 70.0 66.0 69.0 66.0 21:39:53 INFO - PROCESS | 28213 | -------- Summary: end -------- 21:39:53 INFO - PROCESS | 28213 | 21:39:54 INFO - TEST-INFO | 28213: exit 0 21:39:54 INFO - TEST-OK | kraken | took 62087ms 21:39:54 INFO - SUITE-END | took 1178s 21:39:54 INFO - Completed test suite (00:19:38) 21:39:54 INFO - javascript benchmark 21:39:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2930.750886174675, 2955.187323486041, 2960.363521842804, 2978.568107624393, 3002.534607135893, 4992.226204938241, 5052.545270925616, 5052.974735126324, 5132.21361961066, 5132.384113906332, 5089.567386772129, 5090.847274581768, 5103.617228707843, 5122.282880396738, 5183.092958732216, 4742.19382704941, 4751.16854550454, 4752.952470475286, 4777.641676874231, 4788.784504697297, 4777.474477807438, 4822.614190864722, 4826.975865120687, 4833.178359678863, 4871.658983871131, 4676.766161691919, 4802.97598512007, 4902.215645496722, 4904.0, 4904.411470623512, 4665.206914824488, 4798.688085274446, 4822.276658501235, 4847.0, 4847.466778654345, 4623.398958135454, 4635.582797548237, 4677.0, 4689.953100468986, 4698.271767875985, 5082.390113186404, 5161.251618515332, 5166.7416629168765, 5175.327207463043, 5224.8693782655355, 5497.47773961473, 5527.2538207342295, 5527.50252477275, 5531.806386776484, 5539.556835453154, 5301.60237982149, 5339.6262261641705, 5521.171824226398, 5606.579506537026, 5629.493345598916, 5234.293370394986, 5241.554467870274, 5243.79024839006, 5248.737563121828, 5252.107141785906, 5726.885462290814, 5732.3121225453215, 5740.540756739534, 5741.981750290611, 5805.535557155417, 5319.494648008433, 5369.033573956725, 5382.407935127133, 5431.891362172734, 5441.700706461183, 5528.889422211533, 5534.667919924817, 5534.916976245359, 5538.584606154554, 5599.076152434803, 5511.724413779295, 5512.0, 5520.779168833202, 5524.254225679562, 5526.806561770319, 5218.634695571273, 5239.214117882349, 5296.4968328009545, 5367.490088441592, 5596.748146333425, 4220.873373798791, 4225.19721252961, 4225.260579398654, 4225.535191128974, 4298.290782020931, 3839.788811615388, 3888.922221555553, 3921.0, 3937.468441760383, 3976.4631774710624, 5276.604254680914, 5290.312259406252, 5290.576753859682, 5293.311869456946, 5343.572514198855, 5449.264349312792, 5575.414581468887, 5631.2960879890015, 5642.125470552071, 5646.153077038395, 5156.123459011977, 5192.7403629818355, 5270.472952704698, 5273.762680679379, 5274.894502109936, 4840.685355451885, 4851.054044461367, 4851.102546028996, 4854.0, 4904.092742842586, 5493.2034854946605, 5701.030824759718, 5708.771649133988, 5714.028615135437, 5718.542516598662, 5336.0661884170895, 5499.642523235977, 5543.750531226024, 5543.916841247304, 5641.689707066151, 5682.8579285516535, 5720.0, 5731.054376027909, 5735.13972904051, 5735.741891614971, 5482.39693633692, 5483.506484416422, 5484.1773733938635, 5485.890282194414, 5490.149026900836, 5455.8363249101, 5457.808976685797, 5508.118701007819, 5508.807191748269, 5535.446455354432, 5413.215083812904, 5419.485148910847, 5423.403425623257, 5424.810131645373, 5477.4248703887115, 5339.893202136013, 5386.326709161355, 5390.97304513475, 5397.379301380392, 5463.562914966714, 5246.842594722164, 5277.736113194402, 5306.893862122659, 5315.255864178941, 5358.7320633967365, 5481.945180548143, 5487.560995120461, 5495.313085864267, 5527.143292789624, 5546.833594991996, 5311.787528498817, 5374.973125134349, 5377.24718539397, 5379.542738867083, 5433.701146436984], "value": 5114.83665390166, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.3408248678992, 605.9757609695611, 620.5004970998344, 622.2439735721098, 631.6525910749087, 33050.50424243635, 45229.0, 45979.0, 46005.53994460058, 46088.0, 43459.0, 43894.780526097325, 43906.56093439065, 43953.0, 43970.34044489335, 8174.26431621154, 8931.106889311066, 9090.227330676867, 9094.408863423889, 9100.180983711465, 8110.675572977103, 8416.158384161596, 8421.073681894986, 10729.409882456463, 10913.345199288067, 11063.0, 11105.278156919814, 11120.55517779292, 11126.443677816118, 11126.721831954184, 10890.782184356309, 10949.781004379947, 10965.780684386267, 10969.945150274278, 10975.83536246957, 10751.462426878625, 10792.190585706103, 10809.945950270278, 10823.0, 10829.187810914213, 41192.38211426831, 41469.37795933063, 41561.79219103915, 41567.584324156676, 41663.7916810414, 3123.5470856725647, 3443.8450269737923, 3454.240067185215, 3515.1739341254784, 3688.188598508324, 30612.846935765403, 30805.38389232203, 31567.84216078905, 31576.0, 31670.0, 4292.678049146327, 4411.713238639478, 4422.579854913778, 4434.11317736454, 4480.910381792379, 330604.0, 332102.0, 333517.0, 333790.0, 333842.99999999756, 50872.745636272324, 51139.232911506355, 51166.48833511617, 51180.0, 51183.23225151626, 57714.13428798571, 58311.70844145837, 58495.70752146297, 58518.0, 58519.0, 14690.926545367418, 14872.925635371754, 14873.47942821996, 14873.70252594942, 14876.92561537207, 12148.45331960064, 12158.5136594537, 12186.0, 12186.878131218751, 12186.878131218751, 13592.0, 13819.239941803096, 13844.030917835655, 14302.57092287233, 14329.35517901697, 5674.290713660793, 6268.341824108494, 6273.247210334789, 6445.937300064028, 6731.562448440934, 930.15356026016, 977.7338346840858, 1006.9345492542961, 1027.814993301198, 1113.777244551093, 28945.85527072351, 29103.708962910525, 29135.41729165405, 29710.257243569085, 29956.400871982438, 1060.745421098946, 1095.222392101601, 1101.1081024370285, 1102.4377567440663, 1204.9215951723158, 15208.543743687485, 15709.842901570839, 15995.760063599055, 16039.713402277566, 16112.597185070466, 476610.0, 480026.0, 480082.0, 480650.0, 481911.0, 48425.273620895714, 53118.0, 53954.0, 54260.728696356266, 54474.727626361615, 1284.9678758030936, 1291.877271659191, 1297.6593295426783, 1317.1636011132807, 1324.668832791802, 29046.7095329044, 30531.2367190822, 30865.382692345578, 30983.845080774452, 31010.209081182802, 46858.76570617125, 47178.29232561583, 47197.76401117972, 47311.0, 47464.2880356788, 413703.0, 415001.0, 416122.0, 416508.0, 416743.0, 32328.0, 32498.512522312656, 32591.837040814644, 32596.34807303888, 32752.34495310128, 44728.32907506325, 44848.10303793971, 44902.0, 45352.54647453615, 45852.39516616902, 37689.43465847959, 38043.048923777125, 39090.0, 39592.40611390774, 40027.0, 38203.617963820005, 38372.040698982746, 38723.806380967915, 39587.80206098951, 40686.38970415505, 36729.44905826468, 37150.44274335833, 37158.8142059288, 37336.81331593324, 37364.43953340757, 33256.50115248225, 35039.299214016086, 35161.47257791084, 35634.82182589071, 36188.0, 24301.27096187117, 24619.19925614488, 24659.383515412257, 25040.123595674064, 25112.748872511773], "value": 19530.609848602624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.24201113750206, 382.3213795512966, 392.54856914548265, 397.64013567721213, 420.6109348852311, 13243.45371361822, 15279.541613751577, 16631.916840415783, 19418.126184321703, 19636.70544941827, 17407.912960435213, 17637.0, 17896.91051544744, 17912.28350865967, 19241.0, 5707.1153971134545, 5954.404559544054, 5962.642241465526, 5964.642121472725, 5965.433283838029, 5560.888782224353, 5838.941610583904, 5869.941300587004, 5872.324682661484, 5872.853178670546, 5587.245721827562, 5828.941710582903, 5829.183914252008, 5836.941630583682, 5838.095095260221, 5744.0, 5755.223044888929, 5780.50865676418, 5799.652020878761, 5807.767689292423, 4979.875503112415, 5145.691258524501, 5194.662346947474, 5194.870128246786, 5198.324217851655, 23306.76693233063, 23338.766612333828, 23365.41586460352, 23475.295741127793, 23524.64713029306, 2315.0392587076344, 2353.364591560286, 2354.882255887199, 2356.363781778927, 2438.878056097206, 14031.508897188549, 14346.42614295427, 14816.697565935021, 14937.626559335995, 15038.924805376013, 1825.790034146077, 1900.4108726294892, 1938.4959910423252, 1992.85053620979, 1997.1412292714126, 71831.0, 75235.0, 76071.61964190198, 84229.0, 87460.12539874583, 9811.920688724234, 10369.0, 10883.346999179916, 11002.284851484628, 11102.500387482422, 15103.169325687193, 15229.314680839389, 15286.923565382325, 15440.845591544165, 15464.613384665474, 7674.42441816866, 7747.883781743279, 7842.29419352261, 7963.920360796434, 8178.0, 7381.963090184515, 7403.777886663409, 7499.512531685423, 7691.807704807425, 7720.3437707795465, 4183.205191013698, 4192.790360482025, 4543.863684089482, 4625.930611040837, 4686.625069994392, 1826.8081851405411, 1870.3173341730171, 1892.1201641236892, 1909.8376637985648, 1948.4544327588299, 896.825119101782, 971.2181693736469, 988.7083310423299, 994.9452780097164, 999.0509016434416, 17248.827511724972, 19139.97090916357, 19161.520961975784, 19162.329318473785, 19247.711284330748, 978.88072323419, 1001.4592120254981, 1018.4856647393167, 1022.483645758887, 1058.2697938422464, 9753.21974242059, 10082.29423940317, 10861.83707244392, 10872.61945831892, 10880.619178328721, 476170.0, 477305.0, 478320.0, 493117.0, 493591.0, 92843.0, 96424.51787741156, 96572.0, 98330.0, 100877.0, 961.6057416459358, 1013.8783345998528, 1018.4653057145058, 1033.607229252879, 1049.034887903131, 16245.10651914156, 16362.263698133374, 16591.0, 16884.662306754042, 16990.0, 40782.1843563133, 40799.38800917929, 41078.38382424326, 41347.379789303784, 42531.0, 56027.71986140043, 56200.156997645885, 56463.71768141133, 57546.42453575578, 58792.70603646954, 7516.661750221362, 7893.329067029367, 8015.83968320642, 8123.75628731139, 8280.089190188954, 12439.129260952008, 12632.305223212812, 12907.741845163231, 13022.218666880017, 13064.34678266102, 10911.618093367011, 11047.116230701364, 11363.48864301125, 11809.704757381134, 12072.939635301767, 11251.943740281245, 11291.717707057389, 11391.202615816814, 11398.772024559628, 11624.966397514749, 11015.449227538431, 11246.156538259827, 11420.143489238175, 11777.411129443322, 11970.042396608076, 7067.399271062018, 7336.889946650697, 7366.742164024234, 7402.0, 7858.803529911798, 10364.0, 10805.675829725122, 10817.675469735921, 11171.553137874394, 12187.51249949992], "value": 9089.937161107307, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.9800951277027, 1448.0298200205862, 1483.3325003748312, 1608.1637548474794, 1759.9824001759987, 7626.923730762691, 8685.435446695968, 8950.149735775107, 8965.10348965104, 9165.037671044543, 8866.468011919289, 8956.686515971942, 8991.820163596723, 9030.277577793777, 9055.094490550959, 2244.865308081512, 2266.7279926408773, 2268.8298377621663, 2274.6133157363206, 2277.3054218463362, 2221.3224966385246, 2247.6291411917096, 2293.289080385086, 2296.4144143243448, 2299.31020693792, 2242.237639202671, 2278.8063014643694, 2293.575688497625, 2321.535692861426, 2324.8023917966993, 2186.1583290433296, 2198.8900554972265, 2201.2515744646817, 2201.6037113319517, 2208.569328980849, 2140.636091864387, 2182.0617134632103, 2185.093186327688, 2194.418479103039, 2194.440417693494, 8617.870731939025, 8694.478331300079, 8702.956485217534, 8707.69523066696, 8891.510966896818, 5207.453217412193, 5301.602379821529, 5310.176922577007, 5315.176147697113, 5340.279062326575, 3313.436715758327, 3356.4126277901514, 3386.407378708741, 3396.677315655009, 3397.2630106882234, 1023.447338437243, 1036.8341065429495, 1040.9011143941314, 1053.8840727519967, 1094.3543309447384, 12351.752964940652, 12369.443375048144, 12372.81440778389, 12455.314957677325, 12468.251904885736, 4086.7547947123267, 4138.296489596776, 4271.786410679453, 4304.117655880537, 4331.97834010828, 9637.4217546946, 9672.903270967341, 9698.515074246401, 9701.51492425376, 9718.514074296398, 5076.13705670037, 5092.388913330424, 5094.363204599425, 5095.592352611782, 5114.207297868837, 4154.875353739392, 4227.830886764556, 4245.087306229114, 4357.498887627963, 4763.404574428197, 3449.5688038995127, 3782.167923056923, 3785.905352366213, 3795.9051023724073, 3808.980955095207, 1070.4380200394698, 1122.15277465513, 1125.5947858770999, 1126.2510430563584, 1129.7796929598815, 864.8875646165958, 868.8653258744905, 899.9910000900038, 917.1791246834047, 938.5307346326837, 5636.464535869086, 5670.092785154438, 5720.885582288331, 5854.443827836349, 5941.792037278761, 950.6340059077305, 964.4840010594298, 968.2254196642798, 974.171953839231, 988.421773262635, 3791.9241615167543, 3948.1511475033008, 4013.337799263089, 4044.9797751011056, 4129.710920235615, 11141.554337826557, 11314.264572802742, 11460.541578336773, 11469.197156198987, 11506.88493115075, 11228.831567526493, 11318.717032074099, 11334.319940803578, 11354.0, 11364.318140911571, 8123.837523249502, 8299.336053115736, 8303.833923321621, 8321.916780832235, 8323.0, 5253.50091741284, 5492.231087647812, 5547.33431988164, 5584.636998595079, 5616.719164041863, 10041.899581004096, 10099.444530550596, 10184.032516910882, 10188.337758045704, 10375.066244038073, 9354.859677104985, 9908.207343412365, 10262.640807571699, 10455.797583277716, 10538.683839484827, 6740.258571557027, 7183.20984691694, 7319.634018298957, 7387.741429049957, 7530.774076777706, 8317.625706843328, 8353.498790072616, 8370.0, 8525.147485251673, 8650.524221167896, 7769.92230077692, 7887.211278872067, 7888.132305446511, 7905.486143400891, 7944.602769861368, 7565.962170189114, 7666.923330766844, 7719.807004824925, 7722.382209423345, 7827.412944029106, 6574.408303252731, 6751.93248067513, 6816.897746533707, 6860.862782744417, 6959.304069593, 5019.146745053423, 5122.334096567422, 5148.3564554430695, 5155.407128180307, 5171.276021357088, 5029.119904016856, 5067.265246539305, 5071.721055341992, 5147.305113809588, 5224.52979231871], "value": 4527.882642757537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.3054895935187, 317.1105050333813, 317.94435973704594, 318.85810814187687, 322.71600991127804, 5218.869528261791, 5218.921716174261, 5251.501107394796, 5251.921221181676, 5291.735413229338, 5142.537171654551, 5154.871128221796, 5178.0161769263905, 5210.739463026843, 5211.088059589576, 3811.4473401356786, 3922.607739226083, 3977.3835055566433, 4029.153877685675, 4056.3104272273786, 4050.9797451012705, 4060.127072679373, 4060.8984775380704, 4072.6131017553435, 4079.265732168223, 4029.899252518696, 4030.407988844405, 4032.3749818777987, 4039.485193052605, 4052.5744796796207, 3801.7909015004166, 3834.5015148030716, 3951.269015232177, 4022.3765316376007, 4051.1087560736887, 3555.6977656899194, 3587.228745819635, 3587.3542762302777, 3593.2094939113354, 3593.2993066352074, 5075.847724568269, 5091.0, 5108.489151084899, 5127.230915362688, 5157.252198431206, 4516.36770852081, 4591.1965406053805, 4620.861374158781, 4633.49031606523, 4696.084263568571, 5355.143177091685, 5383.273258110184, 5404.189371594253, 5412.0516614018925, 5425.294711687495, 3906.199229158016, 3906.2031465525893, 3920.7843568603716, 3927.6465118139504, 3936.822842972073, 5282.392524859613, 5487.890242195133, 5587.776488940438, 5624.831255062355, 5626.352969408488, 3896.8636097736444, 3917.6278253565865, 3919.3729003359895, 3925.371940489508, 3951.5060617422823, 3968.900777480586, 3986.661133803659, 3993.740406873544, 4006.23881462527, 4029.6171863672903, 4506.504284528699, 4526.456825181, 4621.168189725814, 4634.72191668501, 4636.768161591907, 5408.891822163535, 5417.295751552273, 5427.348718153847, 5491.842190740261, 5493.890122197534, 1354.6342487528311, 1372.3275594958398, 1376.3324787478066, 1383.986160138406, 1388.2156581531403, 837.3468694418364, 885.5041176940933, 889.5996801439248, 894.5169608411516, 901.4230892228978, 5050.848474545696, 5078.5937125029905, 5161.690298582097, 5247.134222853263, 5280.498352656491, 5577.693226872561, 5584.357798853102, 5587.832365029056, 5589.552835773128, 5601.151619965402, 5118.667286626357, 5253.894922101613, 5270.077736396115, 5274.815381461631, 5285.048691235537, 2903.0, 2953.852307384665, 2957.8521073946217, 2958.3343747656604, 2959.0974752700204, 5718.712514993953, 5726.79956201531, 5758.157389635277, 5767.163761254595, 5777.497850558885, 5464.617476776667, 5660.2075709400715, 5663.377028526858, 5673.347565030074, 5676.403977582377, 5705.286839145107, 5718.942810572007, 5733.168690539848, 5740.847182306635, 5754.654720716687, 5357.0, 5567.077284425709, 5588.3573389060775, 5626.24045753818, 5633.6619802811965, 5469.863253418696, 5497.257870187634, 5504.91742623869, 5524.4199359066715, 5543.36251331086, 5699.971500142473, 5729.2265544151005, 5734.627249228787, 5791.0, 5817.738201780845, 3706.9183575286893, 3849.9230015400094, 3860.4209368594934, 3862.5364956205435, 3889.9416508752956, 5600.8879822402505, 5602.047651899268, 5607.8878422432135, 5620.85947851307, 5649.435056494318, 5424.0, 5443.700596467233, 5446.428125046971, 5462.371827239918, 5501.422350653123, 5192.1952097424955, 5456.399796022355, 5471.398146203994, 5471.972640136773, 5509.834704958857, 5433.945660543344, 5435.701036442875, 5448.400675925565, 5452.5365343946205, 5460.863478413072, 5273.551748101454, 5281.920771188358, 5409.891802163856, 5472.753726082256, 5551.9722401387735, 5347.491988261109, 5349.491798279158, 5409.810656626999, 5410.269613602113, 5419.0], "value": 4131.703768795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.2727590494409, 592.706610227937, 682.290417965316, 717.8012718759674, 796.8127490039841, 13901.930490347546, 14801.777973330409, 14966.401343946229, 14990.400383984655, 15024.0, 13545.187288762681, 13561.593152205425, 13573.932130339359, 13626.727465450685, 13627.591172264823, 634.3529599808193, 652.5953908576689, 747.6448686873719, 755.4522970846134, 765.12775436003, 757.7120694136221, 757.8029712274821, 759.8594260061878, 761.090496856257, 764.1174443517746, 805.7260531419316, 806.6773290683744, 806.6894245715383, 806.8709006558952, 807.5800583696474, 666.8032930285553, 682.4608559238196, 793.0443815202725, 802.7551596762985, 810.9716159934374, 594.3818428834007, 595.8718875441757, 595.8867815115115, 596.4631831351775, 596.704631207555, 13852.099613525088, 13892.305384730724, 13990.930045349809, 13997.5100871469, 14002.019858609901, 13393.397297121654, 13663.931680341633, 13801.309934503335, 13873.722525549534, 14179.64550886236, 12379.319137447437, 12498.0, 12559.372031398394, 12686.64135037872, 12700.364981750876, 4228.513720922103, 4233.745975241495, 4289.463817022872, 4293.978530107361, 4300.784960751981, 76694.1739151986, 77211.0, 77496.0, 77973.22026779717, 79054.60472697657, 10568.0, 10856.402897840537, 10928.617498387677, 11062.557497700163, 11090.778184436265, 20146.496337591678, 20162.29431969874, 20162.495937601678, 20270.79729202689, 20298.89850550738, 7501.062367204099, 7526.059242594676, 7679.19368466303, 7696.846063078707, 7856.960715196502, 4345.087531618332, 4356.542563030836, 4508.120916421266, 4544.409226800561, 4650.558196971282, 3142.1987393214586, 3210.7431405487505, 3220.8872689455757, 3241.0438920518504, 3249.6587858275016, 596.2874365133624, 597.208698474523, 599.4155698194313, 605.9424354686298, 623.1027320658328, 472.4826315184867, 596.7105953612495, 613.3896772711091, 614.7233744814852, 621.8134559632092, 8005.319547838382, 8409.201125893152, 8469.915300847037, 8527.573621318908, 8591.140885911358, 606.6542071019477, 612.7242740766673, 620.3517324396017, 622.9750809967551, 643.9156440649331, 3994.2610617035944, 4098.508179018537, 4136.110736191733, 4148.834046638161, 4327.6105150536605, 120040.39979800045, 122250.0, 122774.24741639296, 124307.41112314176, 127756.36121819331, 98317.0, 98522.50738746261, 99300.0, 102623.4868825651, 102884.0, 89084.55457722669, 91074.0, 95100.52449737846, 96085.0, 96720.0, 7877.448578599443, 7921.722739704313, 8269.857454167377, 8275.9586202071, 8551.529665868187, 40782.388264176654, 44561.0, 45207.32189017101, 49002.0, 56745.43254567401, 71113.64443177752, 72161.63919180371, 72492.63753681198, 73803.26196738178, 75893.0, 11171.497282622464, 11434.428278586203, 11529.135314851588, 11680.357580332824, 11722.648320550397, 13573.253471059186, 13662.56543062964, 13760.724785504433, 13767.0, 14064.859351406354, 11798.351090690094, 12087.697807554881, 12433.502659893504, 12507.56223532172, 12571.0, 12650.00324871689, 12764.0, 12913.612591622266, 13195.67010824737, 13311.267880266678, 11379.601713939972, 11719.76560468803, 11867.940660296988, 12144.757104857677, 12199.817002745143, 10160.898391015995, 10279.94860025695, 10293.279470437297, 10515.684529464128, 10567.78864422692, 8880.333974951775, 10502.0, 11168.832467512831, 11212.327260364404, 11307.321560706385], "value": 7091.2406484517, "unit": "score"}], "name": "dromaeo_css", "value": 7027.7596916048815, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 112.0, 112.0, 110.0, 110.0, 111.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 122.0, 154.0, 124.0, 127.0, 123.0, 121.0, 154.0, 123.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 173.0, 163.0, 162.0, 162.0, 162.0, 161.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 111.0, 76.0, 75.0, 77.0, 76.0, 97.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 105.0, 82.0, 83.0, 83.0, 101.0, 83.0, 83.0, 114.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 53.0, 54.0, 52.0, 53.0, 52.0, 53.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 79.0, 79.0, 85.0, 79.0, 79.0, 87.0, 78.0, 78.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 139.0, 138.0, 129.0, 141.0, 150.0, 132.0, 170.0, 133.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 166.0, 168.0, 173.0, 168.0, 168.0, 166.0, 168.0, 169.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 68.0, 66.0, 67.0, 70.0, 66.0, 69.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1506.8, "alertThreshold": 2.0}]} 21:39:54 INFO - Return code: 0 21:39:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:39:54 INFO - # TBPL SUCCESS # 21:39:54 INFO - Running post-action listener: _resource_record_post_action 21:39:54 INFO - [mozharness: 2016-10-01 04:39:54.533833Z] Finished run-tests step (success) 21:39:54 INFO - Running post-run listener: _resource_record_post_run 21:39:54 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 410488832; Read time: 8; Write time: 331116 21:39:54 INFO - TinderboxPrint: CPU usage
13.0% 21:39:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 21:39:54 INFO - TinderboxPrint: I/O write bytes / time
410,488,832 / 331,116 21:39:54 INFO - TinderboxPrint: CPU idle
8,304.0 (86.9%) 21:39:54 INFO - TinderboxPrint: CPU user
1,195.6 (12.5%) 21:39:54 INFO - TinderboxPrint: Swap in / out
0 / 0 21:39:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 120836096; Read time: 0; Write time: 108332 21:39:54 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289652736; Read time: 8; Write time: 222784 21:39:55 INFO - Running post-run listener: _upload_blobber_files 21:39:55 INFO - Blob upload gear active. 21:39:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:39:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:39:55 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:39:55 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:39:55 INFO - (blobuploader) - INFO - Open directory for files ... 21:39:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:39:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:39:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:39:56 INFO - (blobuploader) - INFO - Done attempting. 21:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:39:59 INFO - (blobuploader) - INFO - Done attempting. 21:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:40:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:40:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:40:01 INFO - (blobuploader) - INFO - Done attempting. 21:40:01 INFO - (blobuploader) - INFO - Iteration through files over. 21:40:01 INFO - Return code: 0 21:40:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:40:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:40:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de51cbba73cc0588d5f7c4f334486fc8b11d7d2efaf8bb881ae0050d97ee86d82edf513b946f37ee1110393e2163211b088c0c137530f152196c6c682cc21bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b16be9eff16ff6b074f64d3cd1b183a61cb25f85b7473daf85f24ffc61ffca967a7e1c1298390fcaec4786d99404440e3aa6fa94c0757bc314d6f256af6b4951", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e696e9681062a357d2ffd876bce262d1067113665cbb85d952419ba167a4f53429a12f01305bc82a8bba9a4250f8369d2d56d9cd122797f2f79b915caabb914c"} 21:40:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:40:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:40:01 INFO - Contents: 21:40:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de51cbba73cc0588d5f7c4f334486fc8b11d7d2efaf8bb881ae0050d97ee86d82edf513b946f37ee1110393e2163211b088c0c137530f152196c6c682cc21bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b16be9eff16ff6b074f64d3cd1b183a61cb25f85b7473daf85f24ffc61ffca967a7e1c1298390fcaec4786d99404440e3aa6fa94c0757bc314d6f256af6b4951", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e696e9681062a357d2ffd876bce262d1067113665cbb85d952419ba167a4f53429a12f01305bc82a8bba9a4250f8369d2d56d9cd122797f2f79b915caabb914c"} 21:40:01 INFO - Running post-run listener: copy_logs_to_upload_dir 21:40:01 INFO - Copying logs to upload dir... 21:40:01 INFO - mkdir: /builds/slave/test/build/upload/logs 21:40:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.014641 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-30 21:40:00.891536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 21:40:00.899186) ========= 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=232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de51cbba73cc0588d5f7c4f334486fc8b11d7d2efaf8bb881ae0050d97ee86d82edf513b946f37ee1110393e2163211b088c0c137530f152196c6c682cc21bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b16be9eff16ff6b074f64d3cd1b183a61cb25f85b7473daf85f24ffc61ffca967a7e1c1298390fcaec4786d99404440e3aa6fa94c0757bc314d6f256af6b4951", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e696e9681062a357d2ffd876bce262d1067113665cbb85d952419ba167a4f53429a12f01305bc82a8bba9a4250f8369d2d56d9cd122797f2f79b915caabb914c"} build_url:https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/RyaOgKm0T4av2wAtEq7dIQ/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/Mozilla-Inbound/sha512/de51cbba73cc0588d5f7c4f334486fc8b11d7d2efaf8bb881ae0050d97ee86d82edf513b946f37ee1110393e2163211b088c0c137530f152196c6c682cc21bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b16be9eff16ff6b074f64d3cd1b183a61cb25f85b7473daf85f24ffc61ffca967a7e1c1298390fcaec4786d99404440e3aa6fa94c0757bc314d6f256af6b4951", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e696e9681062a357d2ffd876bce262d1067113665cbb85d952419ba167a4f53429a12f01305bc82a8bba9a4250f8369d2d56d9cd122797f2f79b915caabb914c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 21:40:00.924501) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 21:40:00.924816) ========= 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=232498196343f89f466a4a9a000001c8-1475290588.802986-1474779543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 21:40:01.008780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 21:40:01.009127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 21:40:01.009488) ========= ========= Total master_lag: 0.18 =========