builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1479138184.98 results: success (0) buildid: 20161114043455 builduid: d00525730d904e358afe39be231f63da revision: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:04.975928) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:04.977155) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:04.978015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:04.995554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:04.996207) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 07:43:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-11-14 07:43:08 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179349 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:05.190241) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:05.190601) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019732 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:05.239825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 07:43:05.240217) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f --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=97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 07:43:08,417 truncating revision to first 12 chars 2016-11-14 07:43:08,417 Setting DEBUG logging. 2016-11-14 07:43:08,418 attempt 1/10 2016-11-14 07:43:08,418 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7e29173b1641?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 07:43:09,852 unpacking tar archive at: mozilla-aurora-7e29173b1641/testing/mozharness/ program finished with exit code 0 elapsedTime=1.768883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 07:43:07.025161) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:07.026090) ========= script_repo_revision: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:07.027098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:07.027768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 07:43:07.038711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-14 07:43:07.039412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:43:10 INFO - MultiFileLogger online at 20161114 07:43:10 in /builds/slave/test 07:43:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:43:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:43:10 INFO - {'append_to_log': False, 07:43:10 INFO - 'base_work_dir': '/builds/slave/test', 07:43:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:43:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:43:10 INFO - 'branch': 'Mozilla-Aurora', 07:43:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:43:10 INFO - 'config_files': ('talos/linux_config.py',), 07:43:10 INFO - 'default_actions': ('clobber', 07:43:10 INFO - 'read-buildbot-config', 07:43:10 INFO - 'download-and-extract', 07:43:10 INFO - 'populate-webroot', 07:43:10 INFO - 'create-virtualenv', 07:43:10 INFO - 'install', 07:43:10 INFO - 'run-tests'), 07:43:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:43:10 INFO - 'download_minidump_stackwalk': True, 07:43:10 INFO - 'download_symbols': 'ondemand', 07:43:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:43:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:43:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:43:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:43:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:43:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:43:10 INFO - 'installer_path': 'installer.exe', 07:43:10 INFO - 'log_level': 'info', 07:43:10 INFO - 'log_name': 'talos', 07:43:10 INFO - 'log_to_console': True, 07:43:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:43:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:43:10 INFO - 'opt_config_files': (), 07:43:10 INFO - 'pip_index': False, 07:43:10 INFO - 'sps_profile': False, 07:43:10 INFO - 'sps_profile_interval': 0, 07:43:10 INFO - 'suite': 'dromaeojs', 07:43:10 INFO - 'system_bits': '32', 07:43:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:43:10 INFO - 'title': 'talos-linux64-ix-068', 07:43:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:43:10 INFO - 'use_talos_json': True, 07:43:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:43:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:43:10 INFO - 'work_dir': 'build'} 07:43:10 INFO - [mozharness: 2016-11-14 15:43:10.315551Z] Running clobber step. 07:43:10 INFO - Running pre-action listener: _resource_record_pre_action 07:43:10 INFO - Running main action method: clobber 07:43:10 INFO - rmtree: /builds/slave/test/build 07:43:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:43:10 INFO - Running post-action listener: _resource_record_post_action 07:43:10 INFO - [mozharness: 2016-11-14 15:43:10.778124Z] Finished clobber step (success) 07:43:10 INFO - [mozharness: 2016-11-14 15:43:10.778223Z] Running read-buildbot-config step. 07:43:10 INFO - Running pre-action listener: _resource_record_pre_action 07:43:10 INFO - Running main action method: read_buildbot_config 07:43:10 INFO - Using buildbot properties: 07:43:10 INFO - { 07:43:10 INFO - "project": "", 07:43:10 INFO - "product": "firefox", 07:43:10 INFO - "script_repo_revision": "production", 07:43:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:43:10 INFO - "repository": "", 07:43:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:43:10 INFO - "buildid": "20161114043455", 07:43:10 INFO - "stage_platform": "linux64-pgo", 07:43:10 INFO - "basedir": "/builds/slave/test", 07:43:10 INFO - "nightly_build": "True", 07:43:10 INFO - "buildnumber": 623, 07:43:10 INFO - "slavename": "talos-linux64-ix-068", 07:43:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:43:10 INFO - "platform": "ubuntu64_hw", 07:43:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:43:10 INFO - "branch": "mozilla-aurora", 07:43:10 INFO - "repo_path": "releases/mozilla-aurora", 07:43:10 INFO - "revision": "7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f", 07:43:10 INFO - "pgo_build": "True", 07:43:10 INFO - "builduid": "d00525730d904e358afe39be231f63da", 07:43:10 INFO - "slavebuilddir": "test" 07:43:10 INFO - } 07:43:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 07:43:10 INFO - Running post-action listener: _resource_record_post_action 07:43:10 INFO - [mozharness: 2016-11-14 15:43:10.780721Z] Finished read-buildbot-config step (success) 07:43:10 INFO - [mozharness: 2016-11-14 15:43:10.780809Z] Running download-and-extract step. 07:43:10 INFO - Running pre-action listener: _resource_record_pre_action 07:43:10 INFO - Running main action method: download_and_extract 07:43:10 INFO - mkdir: /builds/slave/test/build/tests 07:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:10 INFO - trying https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:43:10 INFO - Downloading https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:43:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:43:11 INFO - Downloaded 1361 bytes. 07:43:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:43:11 INFO - Using the following test package requirements: 07:43:11 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:43:11 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:43:11 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:43:11 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:11 INFO - u'jsshell-linux-x86_64.zip'], 07:43:11 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:43:11 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:43:11 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:43:11 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:43:11 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:43:11 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:43:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:43:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:43:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:43:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:43:11 INFO - Fetch https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:43:11 INFO - Http code: 200 07:43:11 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 07:43:11 INFO - x-amz-cf-id: re594gvYBVcezX9BCe3pEh_8GRL_lp5FO91jvqyIxJ6yCpvZqqiryQ== 07:43:11 INFO - x-amz-version-id: .PupNpRub8iqci43oxfMUdKrecmEMiRk 07:43:12 INFO - Expected file size: 21999692 07:43:12 INFO - Obtained file size: 21999692 07:43:16 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:43:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:43:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:43:16 INFO - Fetch https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:43:16 INFO - Http code: 200 07:43:16 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 07:43:16 INFO - x-amz-cf-id: 60f00752yi5Qit-ZeuxDS_zqpmzJMwM7nOZyB92oIQSNxSC9FgdpuA== 07:43:16 INFO - x-amz-version-id: .PupNpRub8iqci43oxfMUdKrecmEMiRk 07:43:17 INFO - Expected file size: 21999692 07:43:17 INFO - Obtained file size: 21999692 07:43:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 07:43:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:43:21 INFO - Fetch https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:43:22 INFO - Http code: 200 07:43:22 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 07:43:22 INFO - x-amz-cf-id: CeKJHvKTpTD0_zaSfyJjha0TIXwikTt6jc-L4Orna85lJyhsr0e-KQ== 07:43:22 INFO - x-amz-version-id: khC2dBqT4macoa3mo70BLo5l_yQ3AZFc 07:43:22 INFO - Expected file size: 14409038 07:43:22 INFO - Obtained file size: 14409038 07:43:22 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')]} 07:43:22 INFO - trying https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:43:22 INFO - Downloading https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:43:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:43:24 INFO - Downloaded 63922512 bytes. 07:43:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:43:24 INFO - mkdir: /builds/slave/test/properties 07:43:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:43:24 INFO - Writing to file /builds/slave/test/properties/build_url 07:43:24 INFO - Contents: 07:43:24 INFO - build_url:https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:43:24 INFO - Running post-action listener: _resource_record_post_action 07:43:24 INFO - Running post-action listener: set_extra_try_arguments 07:43:24 INFO - [mozharness: 2016-11-14 15:43:24.935140Z] Finished download-and-extract step (success) 07:43:24 INFO - [mozharness: 2016-11-14 15:43:24.935438Z] Running populate-webroot step. 07:43:24 INFO - Running pre-action listener: _resource_record_pre_action 07:43:24 INFO - Running main action method: populate_webroot 07:43:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:43:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:43:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:43:24 INFO - '--tppagecycles', 07:43:24 INFO - '7'], 07:43:24 INFO - 'tests': ['tsvgm']}}, 07:43:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:43:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:43:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:43:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:43:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:24 INFO - 'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:24 INFO - 'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['damp', 'tps']}, 07:43:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:24 INFO - 'tests': ['damp', 'tps']}, 07:43:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['dromaeo_dom']}, 07:43:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:43:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['basic_compositor_video']}, 07:43:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:43:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['a11yr', 07:43:24 INFO - 'ts_paint', 07:43:24 INFO - 'tpaint', 07:43:24 INFO - 'sessionrestore', 07:43:24 INFO - 'sessionrestore_no_auto_restore', 07:43:24 INFO - 'tabpaint']}, 07:43:24 INFO - 'other-e10s': {'tests': ['a11yr', 07:43:24 INFO - 'ts_paint', 07:43:24 INFO - 'tpaint', 07:43:24 INFO - 'sessionrestore', 07:43:24 INFO - 'sessionrestore_no_auto_restore', 07:43:24 INFO - 'tabpaint']}, 07:43:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:43:24 INFO - 'ts_paint', 07:43:24 INFO - 'tpaint', 07:43:24 INFO - 'sessionrestore', 07:43:24 INFO - 'sessionrestore_no_auto_restore', 07:43:24 INFO - 'tabpaint']}, 07:43:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:43:24 INFO - 'ts_paint', 07:43:24 INFO - 'tpaint', 07:43:24 INFO - 'sessionrestore', 07:43:24 INFO - 'sessionrestore_no_auto_restore', 07:43:24 INFO - 'tabpaint']}, 07:43:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['a11yr', 07:43:24 INFO - 'ts_paint', 07:43:24 INFO - 'tpaint', 07:43:24 INFO - 'sessionrestore', 07:43:24 INFO - 'sessionrestore_no_auto_restore', 07:43:24 INFO - 'tabpaint']}, 07:43:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['a11yr', 07:43:24 INFO - 'ts_paint', 07:43:24 INFO - 'tpaint', 07:43:24 INFO - 'sessionrestore', 07:43:24 INFO - 'sessionrestore_no_auto_restore', 07:43:24 INFO - 'tabpaint']}, 07:43:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['tsvgx', 07:43:24 INFO - 'tsvgr_opacity', 07:43:24 INFO - 'tart', 07:43:24 INFO - 'tscrollx', 07:43:24 INFO - 'cart']}, 07:43:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:43:24 INFO - 'tsvgr_opacity', 07:43:24 INFO - 'tart', 07:43:24 INFO - 'tscrollx', 07:43:24 INFO - 'cart']}, 07:43:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:24 INFO - 'talos_options': ['--disable-e10s'], 07:43:24 INFO - 'tests': ['tp5o']}, 07:43:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:24 INFO - 'tests': ['tp5o']}, 07:43:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:24 INFO - 'talos_options': ['--disable-e10s', 07:43:24 INFO - '--xperf_path', 07:43:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:24 INFO - 'tests': ['tp5n']}, 07:43:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:24 INFO - 'talos_options': ['--xperf_path', 07:43:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:24 INFO - 'tests': ['tp5n']}}, 07:43:24 INFO - 'talos.zip': {'path': '', 07:43:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:43:24 INFO - Running post-action listener: _resource_record_post_action 07:43:24 INFO - [mozharness: 2016-11-14 15:43:24.958446Z] Finished populate-webroot step (success) 07:43:24 INFO - [mozharness: 2016-11-14 15:43:24.958537Z] Running create-virtualenv step. 07:43:24 INFO - Running pre-action listener: _resource_record_pre_action 07:43:24 INFO - Running main action method: create_virtualenv 07:43:24 INFO - Creating virtualenv /builds/slave/test/build/venv 07:43:24 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 07:43:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:43:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:43:25 INFO - Using real prefix '/usr' 07:43:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:43:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:43:27 INFO - Installing pip.................done. 07:43:27 INFO - Return code: 0 07:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:43:27 INFO - Reading from file tmpfile_stdout 07:43:27 INFO - Output received: 07:43:27 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) 07:43:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f075ddcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', '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 07:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:43:27 INFO - Using env: {'DISPLAY': ':0', 07:43:27 INFO - 'HOME': '/home/cltbld', 07:43:27 INFO - 'LANG': 'en_US.UTF-8', 07:43:27 INFO - 'LANGUAGE': 'en_US:en', 07:43:27 INFO - 'LOGNAME': 'cltbld', 07:43:27 INFO - 'MAIL': '/var/mail/cltbld', 07:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:27 INFO - 'MOZ_NO_REMOTE': '1', 07:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:27 INFO - 'NO_EM_RESTART': '1', 07:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:27 INFO - 'PWD': '/builds/slave/test', 07:43:27 INFO - 'SHELL': '/bin/bash', 07:43:27 INFO - 'SHLVL': '1', 07:43:27 INFO - 'TERM': 'linux', 07:43:27 INFO - 'TMOUT': '86400', 07:43:27 INFO - 'USER': 'cltbld', 07:43:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:27 INFO - '_': '/tools/buildbot/bin/python'} 07:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:27 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 07:43:27 INFO - Cleaning up... 07:43:27 INFO - Return code: 0 07:43:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f075ddcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', '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 07:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:43:27 INFO - Using env: {'DISPLAY': ':0', 07:43:27 INFO - 'HOME': '/home/cltbld', 07:43:27 INFO - 'LANG': 'en_US.UTF-8', 07:43:27 INFO - 'LANGUAGE': 'en_US:en', 07:43:27 INFO - 'LOGNAME': 'cltbld', 07:43:27 INFO - 'MAIL': '/var/mail/cltbld', 07:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:27 INFO - 'MOZ_NO_REMOTE': '1', 07:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:28 INFO - 'NO_EM_RESTART': '1', 07:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:28 INFO - 'PWD': '/builds/slave/test', 07:43:28 INFO - 'SHELL': '/bin/bash', 07:43:28 INFO - 'SHLVL': '1', 07:43:28 INFO - 'TERM': 'linux', 07:43:28 INFO - 'TMOUT': '86400', 07:43:28 INFO - 'USER': 'cltbld', 07:43:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:28 INFO - '_': '/tools/buildbot/bin/python'} 07:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:28 INFO - Downloading/unpacking psutil>=3.1.1 07:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:43:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:30 INFO - Installing collected packages: psutil 07:43:30 INFO - Running setup.py install for psutil 07:43:30 INFO - building 'psutil._psutil_linux' extension 07:43:30 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 07:43:30 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 07:43:30 INFO - building 'psutil._psutil_posix' extension 07:43:30 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 07:43:30 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 07:43:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:30 INFO - Successfully installed psutil 07:43:30 INFO - Cleaning up... 07:43:30 INFO - Return code: 0 07:43:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f075ddcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', '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 07:43:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:43:30 INFO - Using env: {'DISPLAY': ':0', 07:43:30 INFO - 'HOME': '/home/cltbld', 07:43:30 INFO - 'LANG': 'en_US.UTF-8', 07:43:30 INFO - 'LANGUAGE': 'en_US:en', 07:43:30 INFO - 'LOGNAME': 'cltbld', 07:43:30 INFO - 'MAIL': '/var/mail/cltbld', 07:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:30 INFO - 'MOZ_NO_REMOTE': '1', 07:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:30 INFO - 'NO_EM_RESTART': '1', 07:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:30 INFO - 'PWD': '/builds/slave/test', 07:43:30 INFO - 'SHELL': '/bin/bash', 07:43:30 INFO - 'SHLVL': '1', 07:43:30 INFO - 'TERM': 'linux', 07:43:30 INFO - 'TMOUT': '86400', 07:43:30 INFO - 'USER': 'cltbld', 07:43:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:30 INFO - '_': '/tools/buildbot/bin/python'} 07:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:43:30 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 07:43:30 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 07:43:30 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 07:43:30 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 07:43:30 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 07:43:30 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 07:43:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:43:32 INFO - Installing collected packages: mozsystemmonitor 07:43:32 INFO - Running setup.py install for mozsystemmonitor 07:43:33 INFO - Successfully installed mozsystemmonitor 07:43:33 INFO - Cleaning up... 07:43:33 INFO - Return code: 0 07:43:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:43: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')]} 07:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43: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')]} 07:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f075ddcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', '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 07:43:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:43:33 INFO - Using env: {'DISPLAY': ':0', 07:43:33 INFO - 'HOME': '/home/cltbld', 07:43:33 INFO - 'LANG': 'en_US.UTF-8', 07:43:33 INFO - 'LANGUAGE': 'en_US:en', 07:43:33 INFO - 'LOGNAME': 'cltbld', 07:43:33 INFO - 'MAIL': '/var/mail/cltbld', 07:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:33 INFO - 'MOZ_NO_REMOTE': '1', 07:43:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:33 INFO - 'NO_EM_RESTART': '1', 07:43:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:33 INFO - 'PWD': '/builds/slave/test', 07:43:33 INFO - 'SHELL': '/bin/bash', 07:43:33 INFO - 'SHLVL': '1', 07:43:33 INFO - 'TERM': 'linux', 07:43:33 INFO - 'TMOUT': '86400', 07:43:33 INFO - 'USER': 'cltbld', 07:43:33 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:33 INFO - '_': '/tools/buildbot/bin/python'} 07:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:33 INFO - Downloading/unpacking jsonschema==2.5.1 07:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:43:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:35 INFO - Downloading functools32-3.2.3-2.tar.gz 07:43:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:43:35 INFO - warning: no files found matching '*.txt' 07:43:35 INFO - no previously-included directories found matching 'build' 07:43:35 INFO - no previously-included directories found matching 'dist' 07:43:35 INFO - no previously-included directories found matching '.git*' 07:43:35 INFO - Installing collected packages: jsonschema, functools32 07:43:35 INFO - Running setup.py install for functools32 07:43:35 INFO - warning: no files found matching '*.txt' 07:43:35 INFO - no previously-included directories found matching 'build' 07:43:35 INFO - no previously-included directories found matching 'dist' 07:43:35 INFO - no previously-included directories found matching '.git*' 07:43:35 INFO - Successfully installed jsonschema functools32 07:43:35 INFO - Cleaning up... 07:43:35 INFO - Return code: 0 07:43:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:35 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 0x7f075ddcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', '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 07:43:35 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 07:43:35 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 07:43:35 INFO - Using env: {'DISPLAY': ':0', 07:43:35 INFO - 'HOME': '/home/cltbld', 07:43:35 INFO - 'LANG': 'en_US.UTF-8', 07:43:35 INFO - 'LANGUAGE': 'en_US:en', 07:43:35 INFO - 'LOGNAME': 'cltbld', 07:43:35 INFO - 'MAIL': '/var/mail/cltbld', 07:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:35 INFO - 'MOZ_NO_REMOTE': '1', 07:43:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:35 INFO - 'NO_EM_RESTART': '1', 07:43:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:35 INFO - 'PWD': '/builds/slave/test', 07:43:35 INFO - 'SHELL': '/bin/bash', 07:43:35 INFO - 'SHLVL': '1', 07:43:35 INFO - 'TERM': 'linux', 07:43:35 INFO - 'TMOUT': '86400', 07:43:35 INFO - 'USER': 'cltbld', 07:43:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:35 INFO - '_': '/tools/buildbot/bin/python'} 07:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:43:35 INFO - Cleaning up... 07:43:35 INFO - Return code: 0 07:43:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:35 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 0x7f075ddcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', '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 07:43:35 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 07:43:35 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 07:43:35 INFO - Using env: {'DISPLAY': ':0', 07:43:35 INFO - 'HOME': '/home/cltbld', 07:43:35 INFO - 'LANG': 'en_US.UTF-8', 07:43:35 INFO - 'LANGUAGE': 'en_US:en', 07:43:35 INFO - 'LOGNAME': 'cltbld', 07:43:35 INFO - 'MAIL': '/var/mail/cltbld', 07:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:35 INFO - 'MOZ_NO_REMOTE': '1', 07:43:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:35 INFO - 'NO_EM_RESTART': '1', 07:43:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:35 INFO - 'PWD': '/builds/slave/test', 07:43:35 INFO - 'SHELL': '/bin/bash', 07:43:35 INFO - 'SHLVL': '1', 07:43:35 INFO - 'TERM': 'linux', 07:43:35 INFO - 'TMOUT': '86400', 07:43:35 INFO - 'USER': 'cltbld', 07:43:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:35 INFO - '_': '/tools/buildbot/bin/python'} 07:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:36 INFO - Downloading/unpacking blobuploader==1.2.4 07:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:38 INFO - Downloading blobuploader-1.2.4.tar.gz 07:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:43:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:43:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:38 INFO - Downloading docopt-0.6.1.tar.gz 07:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:43:38 INFO - Installing collected packages: blobuploader, requests, docopt 07:43:38 INFO - Running setup.py install for blobuploader 07:43:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:43:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:43:38 INFO - Running setup.py install for requests 07:43:39 INFO - Running setup.py install for docopt 07:43:39 INFO - Successfully installed blobuploader requests docopt 07:43:39 INFO - Cleaning up... 07:43:39 INFO - Return code: 0 07:43:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:39 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 0x7f075ddcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', '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 07:43:39 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 07:43:39 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 07:43:39 INFO - Using env: {'DISPLAY': ':0', 07:43:39 INFO - 'HOME': '/home/cltbld', 07:43:39 INFO - 'LANG': 'en_US.UTF-8', 07:43:39 INFO - 'LANGUAGE': 'en_US:en', 07:43:39 INFO - 'LOGNAME': 'cltbld', 07:43:39 INFO - 'MAIL': '/var/mail/cltbld', 07:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:39 INFO - 'MOZ_NO_REMOTE': '1', 07:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:39 INFO - 'NO_EM_RESTART': '1', 07:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:39 INFO - 'PWD': '/builds/slave/test', 07:43:39 INFO - 'SHELL': '/bin/bash', 07:43:39 INFO - 'SHLVL': '1', 07:43:39 INFO - 'TERM': 'linux', 07:43:39 INFO - 'TMOUT': '86400', 07:43:39 INFO - 'USER': 'cltbld', 07:43:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:39 INFO - '_': '/tools/buildbot/bin/python'} 07:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:39 INFO - Running setup.py (path:/tmp/pip-CAXR94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:39 INFO - Running setup.py (path:/tmp/pip-xF2WeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:39 INFO - Running setup.py (path:/tmp/pip-ho2ndr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:39 INFO - Running setup.py (path:/tmp/pip-EQNr3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:40 INFO - Running setup.py (path:/tmp/pip-DmExvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:40 INFO - Running setup.py (path:/tmp/pip-1r8n_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:40 INFO - Running setup.py (path:/tmp/pip-JvAy8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:40 INFO - Running setup.py (path:/tmp/pip-S8RKGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:40 INFO - Running setup.py (path:/tmp/pip-Uea231-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:40 INFO - Running setup.py (path:/tmp/pip-o9gMEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:40 INFO - Running setup.py (path:/tmp/pip-qaEtSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:40 INFO - Running setup.py (path:/tmp/pip-ZYUh44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:40 INFO - Running setup.py (path:/tmp/pip-4IzohA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:40 INFO - Running setup.py (path:/tmp/pip-gz_iNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:40 INFO - Running setup.py (path:/tmp/pip-HBj10o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:40 INFO - Running setup.py (path:/tmp/pip-wOG76d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:40 INFO - Running setup.py (path:/tmp/pip-8tR6jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:43:40 INFO - Running setup.py install for manifestparser 07:43:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:43:41 INFO - Running setup.py install for mozcrash 07:43:41 INFO - Running setup.py install for mozdebug 07:43:41 INFO - Running setup.py install for mozdevice 07:43:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:43:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:43:41 INFO - Running setup.py install for mozfile 07:43:41 INFO - Running setup.py install for mozhttpd 07:43:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:43:41 INFO - Running setup.py install for mozinfo 07:43:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:43:41 INFO - Running setup.py install for mozInstall 07:43:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:43:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:43:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:43:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:43:41 INFO - Running setup.py install for mozleak 07:43:41 INFO - Running setup.py install for mozlog 07:43:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:43:42 INFO - Running setup.py install for moznetwork 07:43:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:43:42 INFO - Running setup.py install for mozprocess 07:43:42 INFO - Running setup.py install for mozprofile 07:43:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:43:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:43:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:43:42 INFO - Running setup.py install for mozrunner 07:43:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:43:42 INFO - Running setup.py install for mozscreenshot 07:43:42 INFO - Running setup.py install for moztest 07:43:42 INFO - Running setup.py install for mozversion 07:43:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:43:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:43:42 INFO - Cleaning up... 07:43:42 INFO - Return code: 0 07:43:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:42 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 0x7f075ddcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', '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 07:43:42 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 07:43:42 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 07:43:42 INFO - Using env: {'DISPLAY': ':0', 07:43:42 INFO - 'HOME': '/home/cltbld', 07:43:42 INFO - 'LANG': 'en_US.UTF-8', 07:43:42 INFO - 'LANGUAGE': 'en_US:en', 07:43:42 INFO - 'LOGNAME': 'cltbld', 07:43:42 INFO - 'MAIL': '/var/mail/cltbld', 07:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:42 INFO - 'MOZ_NO_REMOTE': '1', 07:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:42 INFO - 'NO_EM_RESTART': '1', 07:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:42 INFO - 'PWD': '/builds/slave/test', 07:43:42 INFO - 'SHELL': '/bin/bash', 07:43:42 INFO - 'SHLVL': '1', 07:43:42 INFO - 'TERM': 'linux', 07:43:42 INFO - 'TMOUT': '86400', 07:43:42 INFO - 'USER': 'cltbld', 07:43:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:42 INFO - '_': '/tools/buildbot/bin/python'} 07:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:43 INFO - Running setup.py (path:/tmp/pip-04OaGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:43 INFO - Running setup.py (path:/tmp/pip-wAYZO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:43 INFO - Running setup.py (path:/tmp/pip-D9Z9tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:43 INFO - Running setup.py (path:/tmp/pip-79eUSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:43 INFO - Running setup.py (path:/tmp/pip-IBsUjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:43 INFO - Running setup.py (path:/tmp/pip-PSQmIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:43 INFO - Running setup.py (path:/tmp/pip-jkMBpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:43 INFO - Running setup.py (path:/tmp/pip-5Mnsri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:43 INFO - Running setup.py (path:/tmp/pip-c4XHvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:43 INFO - Running setup.py (path:/tmp/pip-MphCpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:43 INFO - Running setup.py (path:/tmp/pip-8C2gOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:43 INFO - Running setup.py (path:/tmp/pip-TKbMfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:43 INFO - Running setup.py (path:/tmp/pip-vQgQ1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:43 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)) 07:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:43 INFO - Running setup.py (path:/tmp/pip-uMLpcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 07:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:44 INFO - Running setup.py (path:/tmp/pip-cJaAnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:44 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)) 07:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:44 INFO - Running setup.py (path:/tmp/pip-DdXYnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:44 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)) 07:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:44 INFO - Running setup.py (path:/tmp/pip-AZ9lS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:44 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)) 07:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:43:44 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)) 07:43:44 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)) 07:43:44 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)) 07:43:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:46 INFO - Downloading blessings-1.6.tar.gz 07:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:43:46 INFO - Installing collected packages: blessings 07:43:46 INFO - Running setup.py install for blessings 07:43:46 INFO - Successfully installed blessings 07:43:46 INFO - Cleaning up... 07:43:46 INFO - Return code: 0 07:43:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:43:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:46 INFO - Reading from file tmpfile_stdout 07:43:46 INFO - Current package versions: 07:43:46 INFO - argparse == 1.2.1 07:43:46 INFO - blessings == 1.6 07:43:46 INFO - blobuploader == 1.2.4 07:43:46 INFO - docopt == 0.6.1 07:43:46 INFO - functools32 == 3.2.3-2 07:43:46 INFO - jsonschema == 2.5.1 07:43:46 INFO - manifestparser == 1.1 07:43:46 INFO - mozInstall == 1.12 07:43:46 INFO - mozcrash == 1.0 07:43:46 INFO - mozdebug == 0.1 07:43:46 INFO - mozdevice == 0.48 07:43:46 INFO - mozfile == 1.2 07:43:46 INFO - mozhttpd == 0.7 07:43:46 INFO - mozinfo == 0.9 07:43:46 INFO - mozleak == 0.1 07:43:46 INFO - mozlog == 3.4 07:43:46 INFO - moznetwork == 0.27 07:43:46 INFO - mozprocess == 0.23 07:43:46 INFO - mozprofile == 0.28 07:43:46 INFO - mozrunner == 6.13 07:43:46 INFO - mozscreenshot == 0.1 07:43:46 INFO - mozsystemmonitor == 0.3 07:43:46 INFO - moztest == 0.7 07:43:46 INFO - mozversion == 1.4 07:43:46 INFO - psutil == 3.1.1 07:43:46 INFO - requests == 1.2.3 07:43:46 INFO - wsgiref == 0.1.2 07:43:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43: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')]} 07:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43: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')]} 07:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:46 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 0x7f075ddcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', '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 07:43:46 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 07:43:46 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 07:43:46 INFO - Using env: {'DISPLAY': ':0', 07:43:46 INFO - 'HOME': '/home/cltbld', 07:43:46 INFO - 'LANG': 'en_US.UTF-8', 07:43:46 INFO - 'LANGUAGE': 'en_US:en', 07:43:46 INFO - 'LOGNAME': 'cltbld', 07:43:46 INFO - 'MAIL': '/var/mail/cltbld', 07:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:46 INFO - 'MOZ_NO_REMOTE': '1', 07:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:46 INFO - 'NO_EM_RESTART': '1', 07:43:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:46 INFO - 'PWD': '/builds/slave/test', 07:43:46 INFO - 'SHELL': '/bin/bash', 07:43:46 INFO - 'SHLVL': '1', 07:43:46 INFO - 'TERM': 'linux', 07:43:46 INFO - 'TMOUT': '86400', 07:43:46 INFO - 'USER': 'cltbld', 07:43:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:46 INFO - '_': '/tools/buildbot/bin/python'} 07:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:46 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)) 07:43:46 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)) 07:43:46 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)) 07:43:46 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)) 07:43:46 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)) 07:43:46 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)) 07:43:46 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)) 07:43:46 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)) 07:43:46 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)) 07:43:46 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)) 07:43:46 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)) 07:43:46 INFO - Cleaning up... 07:43:46 INFO - Return code: 0 07:43:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:43: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')]} 07:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43: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')]} 07:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f075ddcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', '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 07:43: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', 'jsonschema'] in /builds/slave/test/build 07:43: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 jsonschema 07:43:46 INFO - Using env: {'DISPLAY': ':0', 07:43:46 INFO - 'HOME': '/home/cltbld', 07:43:46 INFO - 'LANG': 'en_US.UTF-8', 07:43:46 INFO - 'LANGUAGE': 'en_US:en', 07:43:46 INFO - 'LOGNAME': 'cltbld', 07:43:46 INFO - 'MAIL': '/var/mail/cltbld', 07:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:46 INFO - 'MOZ_NO_REMOTE': '1', 07:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:46 INFO - 'NO_EM_RESTART': '1', 07:43:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:46 INFO - 'PWD': '/builds/slave/test', 07:43:46 INFO - 'SHELL': '/bin/bash', 07:43:46 INFO - 'SHLVL': '1', 07:43:46 INFO - 'TERM': 'linux', 07:43:46 INFO - 'TMOUT': '86400', 07:43:46 INFO - 'USER': 'cltbld', 07:43:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:46 INFO - '_': '/tools/buildbot/bin/python'} 07:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:43:47 INFO - Cleaning up... 07:43:47 INFO - Return code: 0 07:43:47 INFO - Running post-action listener: _resource_record_post_action 07:43:47 INFO - Running post-action listener: _start_resource_monitoring 07:43:47 INFO - Starting resource monitoring. 07:43:47 INFO - [mozharness: 2016-11-14 15:43:47.187983Z] Finished create-virtualenv step (success) 07:43:47 INFO - [mozharness: 2016-11-14 15:43:47.188437Z] Running install step. 07:43:47 INFO - Running pre-action listener: _resource_record_pre_action 07:43:47 INFO - Running main action method: install 07:43:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:47 INFO - Reading from file tmpfile_stdout 07:43:47 INFO - Detecting whether we're running mozinstall >=1.0... 07:43:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:43:47 INFO - Reading from file tmpfile_stdout 07:43:47 INFO - Output received: 07:43:47 INFO - Usage: mozinstall [options] installer 07:43:47 INFO - Options: 07:43:47 INFO - -h, --help show this help message and exit 07:43:47 INFO - -d DEST, --destination=DEST 07:43:47 INFO - Directory to install application into. [default: 07:43:47 INFO - "/builds/slave/test"] 07:43:47 INFO - --app=APP Application being installed. [default: firefox] 07:43:47 INFO - mkdir: /builds/slave/test/build/application 07:43:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:44:03 INFO - Reading from file tmpfile_stdout 07:44:03 INFO - Output received: 07:44:03 INFO - /builds/slave/test/build/application/firefox/firefox 07:44:03 INFO - Running post-action listener: _resource_record_post_action 07:44:03 INFO - [mozharness: 2016-11-14 15:44:03.397559Z] Finished install step (success) 07:44:03 INFO - [mozharness: 2016-11-14 15:44:03.397801Z] Running run-tests step. 07:44:03 INFO - Running pre-action listener: _resource_record_pre_action 07:44:03 INFO - Running main action method: run_tests 07:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:44:03 INFO - Python 2.7.3 07:44:03 INFO - Return code: 0 07:44:03 INFO - grabbing minidump binary from tooltool 07:44:03 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')]} 07:44:03 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 0x144bf60>, '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 0x144cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:44:03 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 07:44:03 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 07:44:03 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 07:44:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:44:03 INFO - Return code: 0 07:44:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:44:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:44:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:44:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:44:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 07:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 07:44:03 INFO - Using env: {'DISPLAY': ':0', 07:44:03 INFO - 'HOME': '/home/cltbld', 07:44:03 INFO - 'LANG': 'en_US.UTF-8', 07:44:03 INFO - 'LANGUAGE': 'en_US:en', 07:44:03 INFO - 'LOGNAME': 'cltbld', 07:44:03 INFO - 'MAIL': '/var/mail/cltbld', 07:44:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:44:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:03 INFO - 'MOZ_NO_REMOTE': '1', 07:44:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:03 INFO - 'NO_EM_RESTART': '1', 07:44:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:03 INFO - 'PWD': '/builds/slave/test', 07:44:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:44:03 INFO - 'SHELL': '/bin/bash', 07:44:03 INFO - 'SHLVL': '1', 07:44:03 INFO - 'TERM': 'linux', 07:44:03 INFO - 'TMOUT': '86400', 07:44:03 INFO - 'USER': 'cltbld', 07:44:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511', 07:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:03 INFO - '_': '/tools/buildbot/bin/python'} 07:44:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 07:44:03 INFO - mozversion application_buildid: 20161114043455 07:44:03 INFO - mozversion application_changeset: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f 07:44:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:44:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:44:03 INFO - mozversion application_name: Firefox 07:44:03 INFO - mozversion application_remotingname: firefox-dev 07:44:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:44:03 INFO - mozversion application_vendor: Mozilla 07:44:03 INFO - mozversion application_version: 52.0a2 07:44:03 INFO - mozversion platform_buildid: 20161114043455 07:44:03 INFO - mozversion platform_changeset: 7e29173b1641f54d08c60a64cd9d1b5fbc3bba2f 07:44:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:44:03 INFO - mozversion platform_version: 52.0a2 07:44:03 INFO - using testdate: 1479138243 07:44:03 INFO - actual date: 1479138243 07:44:03 INFO - starting webserver on 'localhost:52764' 07:44:03 INFO - SUITE-START | Running 2 tests 07:44:03 INFO - TEST-START | dromaeo_css 07:44:03 INFO - operating with platform_type : linux_ 07:44:03 INFO - Initialising browser for dromaeo_css test... 07:44:03 INFO - TEST-INFO | started process 11148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6l0Dxp/profile http://localhost:52764/getInfo.html) 07:44:06 ERROR - PROCESS | 11148 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 07:44:07 INFO - PROCESS | 11148 | __metrics Screen width/height:1600/1200 07:44:07 INFO - PROCESS | 11148 | colorDepth:24 07:44:07 INFO - PROCESS | 11148 | Browser inner width/height: 1024/697 07:44:07 INFO - PROCESS | 11148 | __metrics 07:44:08 INFO - PROCESS | 11148 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:44:08 INFO - PROCESS | 11148 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:44:08 INFO - PROCESS | 11148 | console.error: PushService: 07:44:08 INFO - PROCESS | 11148 | stateChangeProcessEnqueue: Error transitioning state 07:44:08 INFO - PROCESS | 11148 | UnknownError 07:44:09 INFO - TEST-INFO | 11148: exit 0 07:44:09 INFO - Browser initialized. 07:44:09 INFO - Running cycle 1/1 for dromaeo_css test... 07:44:09 INFO - TEST-INFO | started process 11239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6l0Dxp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:21 INFO - PROCESS | 11239 | RSS: Main: 144535552 07:44:21 INFO - PROCESS | 11239 | 07:45:12 INFO - PROCESS | 11239 | 1479138312458 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] 07:47:22 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52764/tests/dromaeo/cssquery-ext.html) 07:47:23 INFO - PROCESS | 11239 | RSS: Main: 240013312 07:47:23 INFO - PROCESS | 11239 | 07:50:26 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-ext.html (next: http://localhost:52764/tests/dromaeo/cssquery-jquery.html) 07:50:26 INFO - PROCESS | 11239 | RSS: Main: 229269504 07:50:26 INFO - PROCESS | 11239 | 07:53:28 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52764/tests/dromaeo/cssquery-mootools.html) 07:53:29 INFO - PROCESS | 11239 | RSS: Main: 206802944 07:53:29 INFO - PROCESS | 11239 | 07:56:31 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52764/tests/dromaeo/cssquery-prototype.html) 07:56:31 INFO - PROCESS | 11239 | RSS: Main: 174063616 07:56:31 INFO - PROCESS | 11239 | 07:59:34 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52764/tests/dromaeo/cssquery-yui.html) 07:59:35 INFO - PROCESS | 11239 | RSS: Main: 174018560 07:59:35 INFO - PROCESS | 11239 | 08:02:37 INFO - PROCESS | 11239 | Cycle 1(1): loaded http://localhost:52764/tests/dromaeo/cssquery-yui.html (next: http://localhost:52764/tests/dromaeo/cssquery-dojo.html) 08:02:37 INFO - PROCESS | 11239 | RSS: Main: 266100736 08:02:37 INFO - PROCESS | 11239 | 08:02:37 INFO - PROCESS | 11239 | __start_tp_report 08:02:37 INFO - PROCESS | 11239 | _x_x_mozilla_page_load 08:02:37 INFO - PROCESS | 11239 | _x_x_mozilla_page_load_details 08:02:37 INFO - PROCESS | 11239 | |i|pagename|runs| 08:02:37 INFO - PROCESS | 11239 | |0;dojo.html;3091.721745042946;3134.2634480896986;3139.4819854723987;3153.4796758534844;3180.8727650893966;5360.839174824757;5401.648892821973;5421;5423.322084739408;5430.67415955043;5399.892002159954;5416.593755468336;5429.267048948391;5433.483819037185;5440.102383106782;4915.213565829468;4920.901581968358;4989.925151122736;4991.600671946236;4994.650374473788;4860.198067318888;4860.4896485869;4875.219964805632;4918.065567542156;5031.471695471978;4924.384451943507;4987.451380348159;4995.975020124894;5004.149294619905;5018.673786203904;5007.724575148365;5009.474005229435;5011.849644510652;5015.699058056528;5050.444451110375;4786.449558300805;4833.202521583935;4906.730129842857;4949.034938187055;4983.576396006308;5309.362876454811;5320.5211530962015;5321.388040375367;5378.973105134489;5387.057264978652;5728.369879313273;5734.053881109612;5788.073908174714;5791.5656325775735;5799.971000145015;5627.521660658849;5776.971115144397;5781.219535362714;5816;5841.824745257649;5335.599830012765;5414.296141501619;5414.756335964852;5465.945340546544;5491.258680078218;5922.052471604523;5937.198478205387;5967.283925928829;5976.581639285295;5993.921094202998;5573.247611572467;5730.71346432685;5736.311642602915;5746.683932383676;5756.94243057564;5666.518345940642;5669.0079236133515;5680.062789639664;5702.372738998707;5750.051241545182;5673;5677.801276955287;5702.6293290935955;5774.105013722879;5794.0439827428;5794.710264486759;5800.274965629296;5804.535637149018;5810.12848072784;5829.213056237439;4405.801738921757;4419.624331931822;4453.77731113443;4469.575390337913;4496.100779844044;3988.880333589997;4019.8392064317686;4030.1939612077704;4046.5144182698264;4059.5534491205945;5515.200295957144;5543.750531226024;5546.168074788733;5547.667139971614;5568.359638641527;5571.9442805571425;5623.297087864017;5671.829845104653;5681.062624666966;5762.654240745569;5532.446755324436;5538.723063846792;5545.390007099297;5555.611107222537;5565.721713914288;4966.701997880139;4974.850754477371;4977.427595826454;4979.327790748275;5001.874953126201;5775.595708300462;5816.651000939957;5944.524438045032;6034.909476357858;6043.758249670052;5767.307923049093;5808.970955145197;5826.096954971986;5834.824955251349;5839.854003649943;6053.334133245251;6058.242719660043;6060.727267273071;6065.363136870565;6067.757289708362;5508.256385388082;5533.197686335539;5737.225474561048;5747.9137812932;5757;5756.913646295226;5814.709264536841;5825.563082768725;5883.117532370179;5899.203607513103;5717.971410142923;5724.914126288026;5725.51333136688;5729.255196824386;5730.455606717355;5590.440955904377;5720.942790572041;5724.198612194213;5735.541156707537;5742.483176514133;5477.972610136924;5537.280153580009;5588.776448941997;5608.327000759935;5652.63257888236;5681.715914204356;5713.714314284186;5720.513756330759;5738.942610573841;5751.051076572486;5421.945780542144;5475.370332411823;5478.068728316275;5592.832215033555;5613.46672066153 08:02:37 INFO - PROCESS | 11239 | |1;ext.html;586.3667239381468;613.7882430561456;648.2059477140502;657.224475119359;668.6890595872918;33718.83140584297;44719.55280447195;45571.77214113933;45712.31431528526;48665.27002094971;45618.77190614051;45960.77019614905;46147.30779038317;46208.53791462084;46223.53776462243;8771.868421973675;8978.551072446351;8990.28077753778;8999;9002.054784247657;8878.911210887873;8962.910370896272;8970.416922900024;8977.865332020025;8980.41627294227;9013.549322533847;9050.275977921783;9063.54682265884;9073.727788166332;9073.818523629556;9006.279497640206;9049.547522623843;9050.185483306534;9052.230560402406;9060.229880460169;8854;8880.378373513857;8905.332100092519;8908.51003194824;8930.955345223298;43594.78202608998;43990.340144897855;44172.55827441749;44253.114937701066;44259;3653.725970552193;3674.2835147146316;3702.747263661827;3816.6755825754844;3902.4341470486906;32107.357852843044;32300.676993230238;32511.51232731487;32771.34457310864;34164;4164.66682665386;4237.364395340693;4274.380214868826;4317.503487098992;4321.351797230409;360559;360632;360776.9999999974;361849;362886;38446.615533844866;39577.60422395797;60998;61379.38620613826;61403.38596614066;40404.191916161515;40429.19141617151;40481.797591012444;40524.39213411801;40540.797296013334;17375.04437255963;17506.912465437592;17515.38696145654;17520.474385768448;17551.385701500385;14081.507147249797;14127.434902603985;14166.787498187536;14185;14194.716105677828;9532.809343813224;9550.092741189575;9586.137247647606;9632.27757918159;9634.084761947604;3572.7856328620364;3579.910502237413;3587.4260118380935;3625.4743062255825;3633.4913112164318;1054.7732237568805;1074.6346242277664;1109.4951796932376;1126.5099681638515;1152.7233463968587;31379.117252964894;32559.83720081432;33170.66829331724;33225.501617475755;33712.49431258533;1100.3397961223202;1126.301692950376;1127.0926903842321;1138.0099313597223;1138.4933704501582;13046.282454465096;15699.372025119095;19103.140358683893;19196.90401548011;19554.217831286875;543580;547647;547954;548084;548572;63442;63847.6807615959;64039;64073.67963160248;64093;1310.5740634293702;1356.4438580182077;1377.7037936843426;1398.930053497321;1408.7816388459805;30723;34476.13809654779;34556.481652774724;34572.481412778325;34774.65225347714;53080;53346.73326633342;53495;53745;53792.731036344565;390103;391059;392317;394014;394211;30063;30784;30983.535246971765;31274.687253127177;32426.189345265615;49090.75454622704;50101.74949125231;50103.24845127399;50224.24663630121;51219.74390128026;40118.799406002785;41576.376354354106;42113.36829947492;42250;42342.36486452767;41725.165496690504;41739;42407;43720;43940.78029609832;41072.589274106875;41628;42700.572994269656;42760.572394276904;42896;34274.48588271228;37206.46538578831;37366.626333737404;37449.251014980095;38139.80930095332;28575.571366429103;29065.418691626473;29104.854475727487;29132.1260362181;29142.708572913998 08:02:37 INFO - PROCESS | 11239 | |2;jquery.html;379.16394350457244;426.24341793316876;432.070080382832;433.9067100573377;437.34398402396414;15325.846741532581;19112.61774764504;19506.99999999998;20563.28028519002;20758.48103797402;19605.901970490162;19827.21317835241;19922.203111875544;20118.497037574067;20314.69527957078;5657.0665840136435;5894.056950887859;5896;5899.410058994109;5911.497522710575;5637.492625663689;5742.79900203493;5791.855203619923;5802.013657678183;5810.15752715856;5768.423157684219;5773.307203135609;5774.191613174159;5779.884402311951;5782.335031471372;5582.385937546866;5787.565932555054;5791.333996590404;5798.942010579904;5808.941910580882;5076.923846142311;5217.869553261199;5244.554212891909;5253.106971814763;5255.710935898524;23665.645015324782;23863.52272954531;23989.160379386813;24062.398440038964;24206.273811785675;2450.546648869947;2619.0702300683174;2798.776097912162;2853.9001134960176;2876.266552029219;14336.42654293827;14562.563123106323;14968.70062598742;15076.547703568911;15087.396504139931;1919.4433614251989;1994.9301774437824;2004.2584243829876;2043.1725151313592;2077.3975547091477;54134;54440;54607.72696136533;78693.60653196754;89395.10604893933;10179.18566514677;11149.108071354272;11325.603603873826;11367.374794386224;11438.656840294805;15623.531294061197;15873;15907.761383579256;15910.204489775464;15919.124448155462;7481.177070522238;7863.056433228049;8454.87317690235;8579.14208579137;8699.695510657224;7936.3254123399;8208.794780130545;8525.829483410422;8668.91331086681;8775.561221938877;6819.693113809891;6916.135483064617;7055.435565154775;7057.400120989773;7103.360697537143;1932.8260456558978;2014.5165160361407;2018.132203152629;2026.5136367271748;2094.3245403676997;462.50973967593785;465.6461089571882;956.7416797464784;1068.3429690740138;1093.1091160704;12421.937890310672;12560.371981400893;13037.869621303666;13042.54351097726;13096.476140954446;449.42256160917117;461.186006698178;463.406839245766;484.1503161950754;524.29744142848;6846.520743548003;6988.196357418962;6993.2657071007825;7024.578525288499;7197.676104575306;439231;457450;467143;471890;472016;95652;97053.51473242589;98606;99125.50437247912;100671;1029.5572903651353;1032.2155162076876;1065.7175848400025;1069.7004838645191;1077.9299345542358;17563.82436175622;17911.73132403041;18025;18096.547586310448;18478.81521184771;29636;38605;39270.803645981585;42825.143497130506;43020.35469467898;55739.72130139486;56075.15887261776;57120;57576.71211643915;57940.420595793505;9000.144986226298;9059.547022648972;9086.818263634823;9126.954365228132;9129.5891684873;9462.668806591737;9510.09654082861;9683.128518433376;10015.14871235953;10268.024537668909;8313.584320783815;8393.706220282262;8563.871541927001;8886.644534218558;9050.140236677506;8629.180227878342;8869.334799889904;8876.644934202817;8964.596593153194;9078.727638170865;5609.439056094521;8245.051819040887;8478.957605211934;8729.869051964099;8788.736337909873;12537.373131343578;12556.121071524905;12821.166624169398;12880.098393112392;13048.217106973612;12223.327716975651;12265.141440099107;12547.372631368578;12599.748005040032;12929.806052909025 08:02:37 INFO - PROCESS | 11239 | |3;mootools.html;1456.1554298506865;1483.4956114920928;1648.90930998795;1745.6334169824336;1810.2939853457153;8443.746687599374;9005.819883602324;9007.459552426859;9007.504587247715;9016.09839016098;7821.256980586835;8082.95958520208;8186.345092392609;8536.359773017017;8817.250533704642;2477.7770000699934;2539.428628558578;2541.4535874786916;2542.7838633716156;2544;2466.8149888758326;2498.71264804548;2511.4223728542447;2519.231634351522;2542.211914306571;2465.3097132802845;2469.1851688942697;2497.4880149569385;2498.2380373985925;2498.575242208829;2380.9642855357183;2382.011465241931;2387.7492863249454;2400;2406.5066661334386;2331.8367714260007;2380.19073515004;2401.915932942356;2404.2787163850776;2485.2792690119845;8756.211940925283;8869.423487473294;8892.199702026785;8914.108589141098;8927.553622318923;5428.104362780136;5560.499555040025;5562.332520097574;5570.080936645449;5572.60991730579;3392.5080863274934;3403.540522029544;3458.8443520041405;3576.088097535138;3605.5132557104716;1213.7269114449177;1223.0276929840797;1238.3374894431527;1254.6424269083268;1313.4943046926905;12246.755064898653;12539.18495297812;12539.811902821464;12557;12602.369881505889;4772.7136371817105;4945.752712364368;4952.653314268039;5012.270766585595;5113.74431278442;10311.175105991502;10324;10333.896661033294;10338.948305258577;10339.276250662382;5608.85977850557;5610.887782244332;5632.155176723524;5642.548596112301;5647.322321321386;4381.364702118175;4692.343071969927;4945.975270123627;5039.596832253411;5097.108006098918;4268.16770729711;4324.870253892388;4364.236258654722;4397.098594788061;4407.537208593116;1400.4258254115764;1417.9149251044971;1420.4176287721984;1435.3756116089535;1453.077295917079;881.352206128495;899.8560230363241;940.2478017585904;963.1428029054148;979.1579241852002;5780.710964451845;5903.645781253139;5907.025340818803;6010.9699451502465;6147.415995480422;450.83544506255635;452.50902770493724;495.511920758053;496.5183771741405;500.13975961346426;3823.3118038752737;3829.3298672732717;3870.651641352292;3992.8203230854683;4098.877033688994;10272.178225741924;10715.410652414192;10900.182486313399;10901.182411319025;10923;10334.896651033394;10836.566537338418;10836.891631083747;10844.295120817122;10854.185936054828;8009.959950200212;8480.448770829877;8481.703140390056;8483.830323393497;8485.448445850876;5899.115132729953;5954.821355359346;6006.429389208193;6021.548383871314;6094.451499365078;9674.467904265051;9724.076212759777;9854.359466634645;9913.801723965624;9966.302358835102;10092.192624590161;10132.696019119438;10209.54057067419;10221.795564088528;10229.744256393353;7284.599347035964;7497.850042999218;7623.123340815655;8050.597470126588;8202.917970820215;8426.41015128935;8803.427777194718;8826.029136795076;8831.779205519913;8831.779205519913;7885.329746971572;7932.365410767009;7960.124386317616;8037.115917249215;8188.303994160563;7574.431917606092;7648.235176482307;7726.6136693166245;7852.646630901509;7854.1360450349275;7159.785206443815;7195.208527062124;7259.491835571459;7268.41852651776;7360;5274.446183150714;5385.784568617368;5397.433269506645;5412.512873841373;5506.614536982373;5243.213517972335;5287.735613219401;5326.385730388158;5378.300820893259;5417 08:02:37 INFO - PROCESS | 11239 | |4;prototype.html;359.3639258512433;359.4356859730224;360.4143267190815;368.55957131228195;376.27003612990814;5258.868528286795;5282.89434211316;5307.920381194275;5322.361316642008;5359.678419294845;5232.319798426209;5240.423553409122;5246.737663116838;5252.317198764155;5264.499872512105;3937.8973887311527;4064;4069.125138095309;4126.752394856303;4245.872623821275;4167.145735124307;4177.3290683726445;4220.53574106848;4223.809928553207;4234.491860976687;4154.52222994355;4165.875023749292;4174.561671024544;4178.122594255195;4202.621764041236;3919.451276821247;4010.8596199133035;4129.256733787917;4170.47869016373;4202.642775364097;3729.5710993235584;3730.253949210142;3731.7201209909367;3738.2897249522503;3810.618938106195;5133.793558513747;5139.486051394868;5148.3564554430695;5149.588032957355;5171.534561889448;4500.729956202638;4695.765211739399;4700.1539722849875;4753.191957367256;4758.452777930548;5403.918941215885;5433.1850222466555;5437.429069947638;5441.428649991733;5455.481729235717;3872.341701910682;4042.7170098093147;4059.5534491205945;4076.1440097579543;4106.958930410688;5628.887422251573;5640.915386269209;5700.743466543974;5708.571857110734;5710.944060138347;4061.045654271244;4066.3290557058344;4083.693722970789;4091.509018917749;4100.6831140406175;4161.334186530201;4172.7704976226;4181.686373521998;4182.623563879265;4186.513787605356;4541.205289074399;4691.483936766953;4721.527847215251;4725.291206319011;4747.074320507537;5588.524975377139;5595.804146854841;5609.158626206102;5620.381758006616;5622.943770562324;1389.7567925612977;1394.979075313851;1400.2998500749625;1403.9540542295852;1405.8313002439568;957.129012598546;986.6842610364758;992.1764935103846;998.6205242008135;1006.8540061691014;5161.974190129025;5281.577473802164;5283.471652834763;5322.54758345545;5323.254744335796;5624.3813180550105;5627.943720562824;5637.830865074055;5645.915311270334;5653.434656534314;5255.369355677343;5340.759665815048;5341.946580534222;5380.139177731622;5401.540869026098;2848.61543691599;2879.481693295227;2893.7122980273575;2895.5077636801793;2899.1012786036395;5649.615844118135;5681.971590142106;5701.315842098975;5710.314762228476;5714.942850571524;5344.412114667383;5588.491107401061;5592.5738936570915;5619.634723742944;5623.971880140573;5647.672796892727;5684.8010319638615;5704.3725190228215;5713.657180569179;5720.856978575569;5213.76538055796;5446.210299506629;5496.230527726041;5506.311711036121;5543.833684989457;5375.274337964481;5395.622306438511;5411.83764487066;5413.079776437936;5427.375851777097;5696.401877802937;5703.714814259353;5721.656700597978;5752.382665887095;5809.767609295581;3925.862594809168;4001;4022.6580740637373;4073.6537394321813;4178.874633760992;5592.217089607377;5599.272094627672;5623.212750215055;5641.40765219646;5646.3506696728755;5544.0318686865585;5549.916751248816;5567.4432556744005;5618.550515958632;5625.268715067015;5331.3129903402105;5487.560995120461;5489.560835133259;5528.170774383874;5549.390676703711;5473.522149019663;5486.890262194654;5487.890242195213;5491.869634308406;5523.7790488380015;5342.305500284938;5477.1510415885605;5494;5511.283533140666;5570.777168913198;5440.42875498067;5442.6462279951675;5454.154606036071;5455.817672930701;5467.4532546745 08:02:37 INFO - PROCESS | 11239 | |5;yui.html;779.8323360477497;795.4193438789683;803.6664784114593;826.0170397227299;857.8841856349393;14706.852931470683;15638.296276667548;15701.92149039256;15823;16128.354865805353;14322.57032289033;14554.490592829254;14684.045537040085;14868.628284292898;14875.702485950274;712.3197346534048;834.2783492279165;848.0755975986174;848.3933987199151;848.5502683577714;711.1679335177854;833.0544831616129;849.3841964575695;851.7955690634234;857.2798848966867;900.8828852249198;902.2736696958946;904.2133343990737;905.2215095018279;905.8595917632745;729.8394353242278;897.5915958238986;897.6499165325529;897.7845317123908;897.9551022448884;548.5803360429275;633.5185259203039;650.9707063182168;652.4747578199548;658.8649326887977;13976.371063302075;14019.43922243109;14054.578362649137;14068.296585170701;14075.648108797259;14018.92990535051;14078.436862525487;14134.15195088298;14211.857881421156;14363.856361436356;13067.411966461437;13100.86899131006;13165.275909824955;13236.404361803741;13282.601521954357;4405.207062728708;4413.713108647928;4466.977665111686;4497.9775101124615;4509.977450112761;53165.46834531644;53702.19446708341;58995;64994;65321.346786532;11661.300321980709;11902.523899043941;11956.641300760992;12065.517379304905;12161.966232870305;20406;20498.897505512377;20635.69046464304;21127.8943605281;21132.57734845325;7829.29536341732;8105.067917189481;8166.387520935835;8173.060098088796;8193.46742461738;4329.242382583036;4405.581469760367;4407.911841763147;4539;4551.226291530382;3570.732195085379;3702.4631428442726;3705.6850167735506;3713.5729391120367;3718.4236443351324;599.1073300781803;608.7473698415197;624.2727222785404;640.6732566391081;645.2934037229227;705.5590256089944;728.2135293882594;751.8533885892308;785.5836406704456;788.6411682684364;9433.29250306216;9877.506124693737;10094.949525252327;10185.439800811026;10357.74105647365;760.9809754756176;775.8138046868711;779.516699646223;785.2461636828594;811.338758911497;4609.492955774862;4931.654784165074;5032.295478632995;5049.671771334852;5166.689998600096;56101.7194914031;60186;66432.6678366605;94147;94316.52841735748;79142;79411.60294198607;81138;81344;84790.57604711936;71729.2827071733;74475.62762186154;75040.62479687567;75872.24127758761;76343.23656763473;9566.521673916137;9815.705528834147;9868.703938881845;9955.452450115314;10003.599856005969;48412.273815892084;48962.755186225266;49404;49657.25514117219;50778.79290837414;64771.67614161899;65356;67729.3227067723;68535.31464685289;69408.30591694018;11481.311121332747;11989.460474278503;12833.807492887801;13051.738965220833;13063.412146453622;13523.323833808467;13785.586432407044;13837.654058648613;14041.438342466596;14185.432582696989;13002.739945200854;13010.609681709564;13025.934870325587;14060.78908816389;14063.789043164155;13006.934965325112;13052.869471305165;13348.666283342605;13596.66008349799;13612.251326177155;12346.938265308616;12907.741845163231;13235.933820331222;13257.867421325664;13596.11625244356;10796.298240614335;10808.351498910091;11005.559777609125;11419.486123124314;11640.185187036826;11020.338779673246;11039.337639741641;11307.547698091985;11377.829332560184;11414.942925285653 08:02:37 INFO - PROCESS | 11239 | __end_tp_report 08:02:37 INFO - PROCESS | 11239 | __start_cc_report 08:02:37 INFO - PROCESS | 11239 | _x_x_mozilla_cycle_collect,1018 08:02:37 INFO - PROCESS | 11239 | __end_cc_report 08:02:37 INFO - PROCESS | 11239 | __startTimestamp1479139357888__endTimestamp 08:02:37 INFO - PROCESS | 11239 | 08:02:37 INFO - PROCESS | 11239 | ------- Summary: start ------- 08:02:37 INFO - PROCESS | 11239 | Number of tests: 6 08:02:37 INFO - PROCESS | 11239 | 08:02:37 INFO - PROCESS | 11239 | [#0] dojo.html Cycles:165 Average:5384.29 Median:5571.94 stddev:599.40 (10.8%) stddev-sans-first:573.62 08:02:37 INFO - PROCESS | 11239 | Values: 3091.7 3134.3 3139.5 3153.5 3180.9 5360.8 5401.6 5421.0 5423.3 5430.7 5399.9 5416.6 5429.3 5433.5 5440.1 4915.2 4920.9 4989.9 4991.6 4994.7 4860.2 4860.5 4875.2 4918.1 5031.5 4924.4 4987.5 4996.0 5004.1 5018.7 5007.7 5009.5 5011.8 5015.7 5050.4 4786.4 4833.2 4906.7 4949.0 4983.6 5309.4 5320.5 5321.4 5379.0 5387.1 5728.4 5734.1 5788.1 5791.6 5800.0 5627.5 5777.0 5781.2 5816.0 5841.8 5335.6 5414.3 5414.8 5465.9 5491.3 5922.1 5937.2 5967.3 5976.6 5993.9 5573.2 5730.7 5736.3 5746.7 5756.9 5666.5 5669.0 5680.1 5702.4 5750.1 5673.0 5677.8 5702.6 5774.1 5794.0 5794.7 5800.3 5804.5 5810.1 5829.2 4405.8 4419.6 4453.8 4469.6 4496.1 3988.9 4019.8 4030.2 4046.5 4059.6 5515.2 5543.8 5546.2 5547.7 5568.4 5571.9 5623.3 5671.8 5681.1 5762.7 5532.4 5538.7 5545.4 5555.6 5565.7 4966.7 4974.9 4977.4 4979.3 5001.9 5775.6 5816.7 5944.5 6034.9 6043.8 5767.3 5809.0 5826.1 5834.8 5839.9 6053.3 6058.2 6060.7 6065.4 6067.8 5508.3 5533.2 5737.2 5747.9 5757.0 5756.9 5814.7 5825.6 5883.1 5899.2 5718.0 5724.9 5725.5 5729.3 5730.5 5590.4 5720.9 5724.2 5735.5 5742.5 5478.0 5537.3 5588.8 5608.3 5652.6 5681.7 5713.7 5720.5 5738.9 5751.1 5421.9 5475.4 5478.1 5592.8 5613.5 08:02:37 INFO - PROCESS | 11239 | 08:02:37 INFO - PROCESS | 11239 | [#1] ext.html Cycles:180 Average:59368.94 Median:41602.19 stddev:117008.17 (281.3%) stddev-sans-first:117253.17 08:02:37 INFO - PROCESS | 11239 | Values: 586.4 613.8 648.2 657.2 668.7 33718.8 44719.6 45571.8 45712.3 48665.3 45618.8 45960.8 46147.3 46208.5 46223.5 8771.9 8978.6 8990.3 8999.0 9002.1 8878.9 8962.9 8970.4 8977.9 8980.4 9013.5 9050.3 9063.5 9073.7 9073.8 9006.3 9049.5 9050.2 9052.2 9060.2 8854.0 8880.4 8905.3 8908.5 8931.0 43594.8 43990.3 44172.6 44253.1 44259.0 3653.7 3674.3 3702.7 3816.7 3902.4 32107.4 32300.7 32511.5 32771.3 34164.0 4164.7 4237.4 4274.4 4317.5 4321.4 360559.0 360632.0 360777.0 361849.0 362886.0 38446.6 39577.6 60998.0 61379.4 61403.4 40404.2 40429.2 40481.8 40524.4 40540.8 17375.0 17506.9 17515.4 17520.5 17551.4 14081.5 14127.4 14166.8 14185.0 14194.7 9532.8 9550.1 9586.1 9632.3 9634.1 3572.8 3579.9 3587.4 3625.5 3633.5 1054.8 1074.6 1109.5 1126.5 1152.7 31379.1 32559.8 33170.7 33225.5 33712.5 1100.3 1126.3 1127.1 1138.0 1138.5 13046.3 15699.4 19103.1 19196.9 19554.2 543580.0 547647.0 547954.0 548084.0 548572.0 63442.0 63847.7 64039.0 64073.7 64093.0 1310.6 1356.4 1377.7 1398.9 1408.8 30723.0 34476.1 34556.5 34572.5 34774.7 53080.0 53346.7 53495.0 53745.0 53792.7 390103.0 391059.0 392317.0 394014.0 394211.0 30063.0 30784.0 30983.5 31274.7 32426.2 49090.8 50101.7 50103.2 50224.2 51219.7 40118.8 41576.4 42113.4 42250.0 42342.4 41725.2 41739.0 42407.0 43720.0 43940.8 41072.6 41628.0 42700.6 42760.6 42896.0 34274.5 37206.5 37366.6 37449.3 38139.8 28575.6 29065.4 29104.9 29132.1 29142.7 08:02:37 INFO - PROCESS | 11239 | 08:02:37 INFO - PROCESS | 11239 | [#2] jquery.html Cycles:180 Average:27646.78 Median:464.53 stddev:76266.66 (16418.2%) stddev-sans-first:76453.12 08:02:37 INFO - PROCESS | 11239 | Values: 379.2 426.2 432.1 433.9 437.3 15325.8 19112.6 19507.0 20563.3 20758.5 19605.9 19827.2 19922.2 20118.5 20314.7 5657.1 5894.1 5896.0 5899.4 5911.5 5637.5 5742.8 5791.9 5802.0 5810.2 5768.4 5773.3 5774.2 5779.9 5782.3 5582.4 5787.6 5791.3 5798.9 5808.9 5076.9 5217.9 5244.6 5253.1 5255.7 23665.6 23863.5 23989.2 24062.4 24206.3 2450.5 2619.1 2798.8 2853.9 2876.3 14336.4 14562.6 14968.7 15076.5 15087.4 1919.4 1994.9 2004.3 2043.2 2077.4 54134.0 54440.0 54607.7 78693.6 89395.1 10179.2 11149.1 11325.6 11367.4 11438.7 15623.5 15873.0 15907.8 15910.2 15919.1 7481.2 7863.1 8454.9 8579.1 8699.7 7936.3 8208.8 8525.8 8668.9 8775.6 6819.7 6916.1 7055.4 7057.4 7103.4 1932.8 2014.5 2018.1 2026.5 2094.3 462.5 465.6 956.7 1068.3 1093.1 12421.9 12560.4 13037.9 13042.5 13096.5 449.4 461.2 463.4 484.2 524.3 6846.5 6988.2 6993.3 7024.6 7197.7 439231.0 457450.0 467143.0 471890.0 472016.0 95652.0 97053.5 98606.0 99125.5 100671.0 1029.6 1032.2 1065.7 1069.7 1077.9 17563.8 17911.7 18025.0 18096.5 18478.8 29636.0 38605.0 39270.8 42825.1 43020.4 55739.7 56075.2 57120.0 57576.7 57940.4 9000.1 9059.5 9086.8 9127.0 9129.6 9462.7 9510.1 9683.1 10015.1 10268.0 8313.6 8393.7 8563.9 8886.6 9050.1 8629.2 8869.3 8876.6 8964.6 9078.7 5609.4 8245.1 8479.0 8729.9 8788.7 12537.4 12556.1 12821.2 12880.1 13048.2 12223.3 12265.1 12547.4 12599.7 12929.8 08:02:37 INFO - PROCESS | 11239 | 08:02:37 INFO - PROCESS | 11239 | [#3] mootools.html Cycles:180 Average:5878.79 Median:2756.21 stddev:3271.38 (118.7%) stddev-sans-first:3263.67 08:02:37 INFO - PROCESS | 11239 | Values: 1456.2 1483.5 1648.9 1745.6 1810.3 8443.7 9005.8 9007.5 9007.5 9016.1 7821.3 8083.0 8186.3 8536.4 8817.3 2477.8 2539.4 2541.5 2542.8 2544.0 2466.8 2498.7 2511.4 2519.2 2542.2 2465.3 2469.2 2497.5 2498.2 2498.6 2381.0 2382.0 2387.7 2400.0 2406.5 2331.8 2380.2 2401.9 2404.3 2485.3 8756.2 8869.4 8892.2 8914.1 8927.6 5428.1 5560.5 5562.3 5570.1 5572.6 3392.5 3403.5 3458.8 3576.1 3605.5 1213.7 1223.0 1238.3 1254.6 1313.5 12246.8 12539.2 12539.8 12557.0 12602.4 4772.7 4945.8 4952.7 5012.3 5113.7 10311.2 10324.0 10333.9 10338.9 10339.3 5608.9 5610.9 5632.2 5642.5 5647.3 4381.4 4692.3 4946.0 5039.6 5097.1 4268.2 4324.9 4364.2 4397.1 4407.5 1400.4 1417.9 1420.4 1435.4 1453.1 881.4 899.9 940.2 963.1 979.2 5780.7 5903.6 5907.0 6011.0 6147.4 450.8 452.5 495.5 496.5 500.1 3823.3 3829.3 3870.7 3992.8 4098.9 10272.2 10715.4 10900.2 10901.2 10923.0 10334.9 10836.6 10836.9 10844.3 10854.2 8010.0 8480.4 8481.7 8483.8 8485.4 5899.1 5954.8 6006.4 6021.5 6094.5 9674.5 9724.1 9854.4 9913.8 9966.3 10092.2 10132.7 10209.5 10221.8 10229.7 7284.6 7497.9 7623.1 8050.6 8202.9 8426.4 8803.4 8826.0 8831.8 8831.8 7885.3 7932.4 7960.1 8037.1 8188.3 7574.4 7648.2 7726.6 7852.6 7854.1 7159.8 7195.2 7259.5 7268.4 7360.0 5274.4 5385.8 5397.4 5412.5 5506.6 5243.2 5287.7 5326.4 5378.3 5417.0 08:02:37 INFO - PROCESS | 11239 | 08:02:37 INFO - PROCESS | 11239 | [#4] prototype.html Cycles:180 Average:4637.18 Median:5322.90 stddev:1338.18 (25.1%) stddev-sans-first:1302.85 08:02:37 INFO - PROCESS | 11239 | Values: 359.4 359.4 360.4 368.6 376.3 5258.9 5282.9 5307.9 5322.4 5359.7 5232.3 5240.4 5246.7 5252.3 5264.5 3937.9 4064.0 4069.1 4126.8 4245.9 4167.1 4177.3 4220.5 4223.8 4234.5 4154.5 4165.9 4174.6 4178.1 4202.6 3919.5 4010.9 4129.3 4170.5 4202.6 3729.6 3730.3 3731.7 3738.3 3810.6 5133.8 5139.5 5148.4 5149.6 5171.5 4500.7 4695.8 4700.2 4753.2 4758.5 5403.9 5433.2 5437.4 5441.4 5455.5 3872.3 4042.7 4059.6 4076.1 4107.0 5628.9 5640.9 5700.7 5708.6 5710.9 4061.0 4066.3 4083.7 4091.5 4100.7 4161.3 4172.8 4181.7 4182.6 4186.5 4541.2 4691.5 4721.5 4725.3 4747.1 5588.5 5595.8 5609.2 5620.4 5622.9 1389.8 1395.0 1400.3 1404.0 1405.8 957.1 986.7 992.2 998.6 1006.9 5162.0 5281.6 5283.5 5322.5 5323.3 5624.4 5627.9 5637.8 5645.9 5653.4 5255.4 5340.8 5341.9 5380.1 5401.5 2848.6 2879.5 2893.7 2895.5 2899.1 5649.6 5682.0 5701.3 5710.3 5714.9 5344.4 5588.5 5592.6 5619.6 5624.0 5647.7 5684.8 5704.4 5713.7 5720.9 5213.8 5446.2 5496.2 5506.3 5543.8 5375.3 5395.6 5411.8 5413.1 5427.4 5696.4 5703.7 5721.7 5752.4 5809.8 3925.9 4001.0 4022.7 4073.7 4178.9 5592.2 5599.3 5623.2 5641.4 5646.4 5544.0 5549.9 5567.4 5618.6 5625.3 5331.3 5487.6 5489.6 5528.2 5549.4 5473.5 5486.9 5487.9 5491.9 5523.8 5342.3 5477.2 5494.0 5511.3 5570.8 5440.4 5442.6 5454.2 5455.8 5467.5 08:02:37 INFO - PROCESS | 11239 | 08:02:37 INFO - PROCESS | 11239 | [#5] yui.html Cycles:180 Average:18091.70 Median:48687.51 stddev:23488.80 (48.2%) stddev-sans-first:23518.72 08:02:37 INFO - PROCESS | 11239 | Values: 779.8 795.4 803.7 826.0 857.9 14706.9 15638.3 15701.9 15823.0 16128.4 14322.6 14554.5 14684.0 14868.6 14875.7 712.3 834.3 848.1 848.4 848.6 711.2 833.1 849.4 851.8 857.3 900.9 902.3 904.2 905.2 905.9 729.8 897.6 897.6 897.8 898.0 548.6 633.5 651.0 652.5 658.9 13976.4 14019.4 14054.6 14068.3 14075.6 14018.9 14078.4 14134.2 14211.9 14363.9 13067.4 13100.9 13165.3 13236.4 13282.6 4405.2 4413.7 4467.0 4498.0 4510.0 53165.5 53702.2 58995.0 64994.0 65321.3 11661.3 11902.5 11956.6 12065.5 12162.0 20406.0 20498.9 20635.7 21127.9 21132.6 7829.3 8105.1 8166.4 8173.1 8193.5 4329.2 4405.6 4407.9 4539.0 4551.2 3570.7 3702.5 3705.7 3713.6 3718.4 599.1 608.7 624.3 640.7 645.3 705.6 728.2 751.9 785.6 788.6 9433.3 9877.5 10094.9 10185.4 10357.7 761.0 775.8 779.5 785.2 811.3 4609.5 4931.7 5032.3 5049.7 5166.7 56101.7 60186.0 66432.7 94147.0 94316.5 79142.0 79411.6 81138.0 81344.0 84790.6 71729.3 74475.6 75040.6 75872.2 76343.2 9566.5 9815.7 9868.7 9955.5 10003.6 48412.3 48962.8 49404.0 49657.3 50778.8 64771.7 65356.0 67729.3 68535.3 69408.3 11481.3 11989.5 12833.8 13051.7 13063.4 13523.3 13785.6 13837.7 14041.4 14185.4 13002.7 13010.6 13025.9 14060.8 14063.8 13006.9 13052.9 13348.7 13596.7 13612.3 12346.9 12907.7 13235.9 13257.9 13596.1 10796.3 10808.4 11005.6 11419.5 11640.2 11020.3 11039.3 11307.5 11377.8 11414.9 08:02:37 INFO - PROCESS | 11239 | -------- Summary: end -------- 08:02:37 INFO - PROCESS | 11239 | 08:02:38 INFO - TEST-INFO | 11239: exit 0 08:02:38 INFO - TEST-OK | dromaeo_css | took 1114989ms 08:02:38 INFO - TEST-START | kraken 08:02:38 INFO - operating with platform_type : linux_ 08:02:38 INFO - Initialising browser for kraken test... 08:02:38 INFO - TEST-INFO | started process 11554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8WmePx/profile http://localhost:52764/getInfo.html) 08:02:41 ERROR - PROCESS | 11554 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 08:02:42 INFO - PROCESS | 11554 | __metrics Screen width/height:1600/1200 08:02:42 INFO - PROCESS | 11554 | colorDepth:24 08:02:42 INFO - PROCESS | 11554 | Browser inner width/height: 1024/697 08:02:42 INFO - PROCESS | 11554 | __metrics 08:02:43 INFO - PROCESS | 11554 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:02:43 INFO - PROCESS | 11554 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:02:43 INFO - PROCESS | 11554 | console.error: PushService: 08:02:43 INFO - PROCESS | 11554 | stateChangeProcessEnqueue: Error transitioning state 08:02:43 INFO - PROCESS | 11554 | UnknownError 08:02:44 INFO - TEST-INFO | 11554: exit 0 08:02:44 INFO - Browser initialized. 08:02:44 INFO - Running cycle 1/1 for kraken test... 08:02:44 INFO - TEST-INFO | started process 11647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8WmePx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:56 INFO - PROCESS | 11647 | RSS: Main: 145010688 08:02:56 INFO - PROCESS | 11647 | 08:02:58 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52764/tests/kraken/driver.html?testName=audio-beat-detection) 08:02:59 INFO - PROCESS | 11647 | RSS: Main: 185425920 08:02:59 INFO - PROCESS | 11647 | 08:03:02 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52764/tests/kraken/driver.html?testName=audio-dft) 08:03:02 INFO - PROCESS | 11647 | RSS: Main: 175443968 08:03:02 INFO - PROCESS | 11647 | 08:03:05 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52764/tests/kraken/driver.html?testName=audio-fft) 08:03:06 INFO - PROCESS | 11647 | RSS: Main: 266776576 08:03:06 INFO - PROCESS | 11647 | 08:03:08 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52764/tests/kraken/driver.html?testName=audio-oscillator) 08:03:08 INFO - PROCESS | 11647 | RSS: Main: 173436928 08:03:08 INFO - PROCESS | 11647 | 08:03:11 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52764/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:03:11 INFO - PROCESS | 11647 | RSS: Main: 175312896 08:03:11 INFO - PROCESS | 11647 | 08:03:14 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52764/tests/kraken/driver.html?testName=imaging-darkroom) 08:03:15 INFO - PROCESS | 11647 | RSS: Main: 213540864 08:03:15 INFO - PROCESS | 11647 | 08:03:18 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52764/tests/kraken/driver.html?testName=imaging-desaturate) 08:03:19 INFO - PROCESS | 11647 | RSS: Main: 212619264 08:03:19 INFO - PROCESS | 11647 | 08:03:21 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52764/tests/kraken/driver.html?testName=json-parse-financial) 08:03:22 INFO - PROCESS | 11647 | RSS: Main: 210907136 08:03:22 INFO - PROCESS | 11647 | 08:03:23 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52764/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:03:24 INFO - PROCESS | 11647 | RSS: Main: 173699072 08:03:24 INFO - PROCESS | 11647 | 08:03:26 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:03:26 INFO - PROCESS | 11647 | RSS: Main: 181465088 08:03:26 INFO - PROCESS | 11647 | 08:03:28 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:03:29 INFO - PROCESS | 11647 | RSS: Main: 190091264 08:03:29 INFO - PROCESS | 11647 | 08:03:32 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:03:32 INFO - PROCESS | 11647 | RSS: Main: 198270976 08:03:32 INFO - PROCESS | 11647 | 08:03:35 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:03:36 INFO - PROCESS | 11647 | RSS: Main: 195465216 08:03:36 INFO - PROCESS | 11647 | 08:03:37 INFO - PROCESS | 11647 | Cycle 1(1): loaded http://localhost:52764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52764/tests/kraken/driver.html?testName=ai-astar) 08:03:38 INFO - PROCESS | 11647 | RSS: Main: 247152640 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | __start_tp_report 08:03:38 INFO - PROCESS | 11647 | _x_x_mozilla_page_load 08:03:38 INFO - PROCESS | 11647 | _x_x_mozilla_page_load_details 08:03:38 INFO - PROCESS | 11647 | |i|pagename|runs| 08:03:38 INFO - PROCESS | 11647 | |0;ai-astar;109;112;112;110;112;111;113;112;113;112 08:03:38 INFO - PROCESS | 11647 | |1;audio-beat-detection;155;127;126;152;130;123;125;120;148;127 08:03:38 INFO - PROCESS | 11647 | |2;audio-dft;161;162;160;162;160;160;161;163;160;162 08:03:38 INFO - PROCESS | 11647 | |3;audio-fft;76;75;76;113;76;76;75;76;98;75 08:03:38 INFO - PROCESS | 11647 | |4;audio-oscillator;83;82;122;82;82;82;101;83;82;117 08:03:38 INFO - PROCESS | 11647 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 08:03:38 INFO - PROCESS | 11647 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 08:03:38 INFO - PROCESS | 11647 | |7;imaging-desaturate;84;85;84;85;84;85;85;85;85;85 08:03:38 INFO - PROCESS | 11647 | |8;json-parse-financial;52;50;51;51;50;51;51;51;50;51 08:03:38 INFO - PROCESS | 11647 | |9;json-stringify-tinderbox;60;62;59;60;61;60;60;60;60;60 08:03:38 INFO - PROCESS | 11647 | |10;stanford-crypto-aes;75;74;80;84;77;88;75;75;75;74 08:03:38 INFO - PROCESS | 11647 | |11;stanford-crypto-ccm;135;127;128;135;131;147;133;132;165;136 08:03:38 INFO - PROCESS | 11647 | |12;stanford-crypto-pbkdf2;159;156;160;164;156;161;158;158;155;154 08:03:38 INFO - PROCESS | 11647 | |13;stanford-crypto-sha256-iterative;65;62;69;63;68;62;65;62;61;61 08:03:38 INFO - PROCESS | 11647 | __end_tp_report 08:03:38 INFO - PROCESS | 11647 | __start_cc_report 08:03:38 INFO - PROCESS | 11647 | _x_x_mozilla_cycle_collect,1614 08:03:38 INFO - PROCESS | 11647 | __end_cc_report 08:03:38 INFO - PROCESS | 11647 | __startTimestamp1479139418021__endTimestamp 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | ------- Summary: start ------- 08:03:38 INFO - PROCESS | 11647 | Number of tests: 14 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.26 (1.1%) stddev-sans-first:0.93 08:03:38 INFO - PROCESS | 11647 | Values: 109.0 112.0 112.0 110.0 112.0 111.0 113.0 112.0 113.0 112.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:128.50 stddev:13.05 (10.2%) stddev-sans-first:11.23 08:03:38 INFO - PROCESS | 11647 | Values: 155.0 127.0 126.0 152.0 130.0 123.0 125.0 120.0 148.0 127.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 08:03:38 INFO - PROCESS | 11647 | Values: 161.0 162.0 160.0 162.0 160.0 160.0 161.0 163.0 160.0 162.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:13.09 (17.2%) stddev-sans-first:13.73 08:03:38 INFO - PROCESS | 11647 | Values: 76.0 75.0 76.0 113.0 76.0 76.0 75.0 76.0 98.0 75.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:82.00 stddev:15.87 (19.4%) stddev-sans-first:16.52 08:03:38 INFO - PROCESS | 11647 | Values: 83.0 82.0 122.0 82.0 82.0 82.0 101.0 83.0 82.0 117.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:03:38 INFO - PROCESS | 11647 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:03:38 INFO - PROCESS | 11647 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 08:03:38 INFO - PROCESS | 11647 | Values: 84.0 85.0 84.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.63 (1.2%) stddev-sans-first:0.50 08:03:38 INFO - PROCESS | 11647 | Values: 52.0 50.0 51.0 51.0 50.0 51.0 51.0 51.0 50.0 51.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 08:03:38 INFO - PROCESS | 11647 | Values: 60.0 62.0 59.0 60.0 61.0 60.0 60.0 60.0 60.0 60.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:76.00 stddev:4.81 (6.3%) stddev-sans-first:5.00 08:03:38 INFO - PROCESS | 11647 | Values: 75.0 74.0 80.0 84.0 77.0 88.0 75.0 75.0 75.0 74.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:135.00 stddev:11.31 (8.4%) stddev-sans-first:11.97 08:03:38 INFO - PROCESS | 11647 | Values: 135.0 127.0 128.0 135.0 131.0 147.0 133.0 132.0 165.0 136.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.50 stddev:3.03 (1.9%) stddev-sans-first:3.20 08:03:38 INFO - PROCESS | 11647 | Values: 159.0 156.0 160.0 164.0 156.0 161.0 158.0 158.0 155.0 154.0 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - PROCESS | 11647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:2.86 (4.5%) stddev-sans-first:3.00 08:03:38 INFO - PROCESS | 11647 | Values: 65.0 62.0 69.0 63.0 68.0 62.0 65.0 62.0 61.0 61.0 08:03:38 INFO - PROCESS | 11647 | -------- Summary: end -------- 08:03:38 INFO - PROCESS | 11647 | 08:03:38 INFO - TEST-INFO | 11647: exit 0 08:03:39 INFO - TEST-OK | kraken | took 60353ms 08:03:39 INFO - SUITE-END | took 1175s 08:03:39 INFO - Completed test suite (00:19:35) 08:03:39 INFO - javascript benchmark 08:03:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.721745042946, 3134.2634480896986, 3139.4819854723987, 3153.4796758534844, 3180.8727650893966, 5360.839174824757, 5401.648892821973, 5421.0, 5423.322084739408, 5430.67415955043, 5399.892002159954, 5416.593755468336, 5429.267048948391, 5433.483819037185, 5440.102383106782, 4915.213565829468, 4920.901581968358, 4989.925151122736, 4991.600671946236, 4994.650374473788, 4860.198067318888, 4860.4896485869, 4875.219964805632, 4918.065567542156, 5031.471695471978, 4924.384451943507, 4987.451380348159, 4995.975020124894, 5004.149294619905, 5018.673786203904, 5007.724575148365, 5009.474005229435, 5011.849644510652, 5015.699058056528, 5050.444451110375, 4786.449558300805, 4833.202521583935, 4906.730129842857, 4949.034938187055, 4983.576396006308, 5309.362876454811, 5320.5211530962015, 5321.388040375367, 5378.973105134489, 5387.057264978652, 5728.369879313273, 5734.053881109612, 5788.073908174714, 5791.5656325775735, 5799.971000145015, 5627.521660658849, 5776.971115144397, 5781.219535362714, 5816.0, 5841.824745257649, 5335.599830012765, 5414.296141501619, 5414.756335964852, 5465.945340546544, 5491.258680078218, 5922.052471604523, 5937.198478205387, 5967.283925928829, 5976.581639285295, 5993.921094202998, 5573.247611572467, 5730.71346432685, 5736.311642602915, 5746.683932383676, 5756.94243057564, 5666.518345940642, 5669.0079236133515, 5680.062789639664, 5702.372738998707, 5750.051241545182, 5673.0, 5677.801276955287, 5702.6293290935955, 5774.105013722879, 5794.0439827428, 5794.710264486759, 5800.274965629296, 5804.535637149018, 5810.12848072784, 5829.213056237439, 4405.801738921757, 4419.624331931822, 4453.77731113443, 4469.575390337913, 4496.100779844044, 3988.880333589997, 4019.8392064317686, 4030.1939612077704, 4046.5144182698264, 4059.5534491205945, 5515.200295957144, 5543.750531226024, 5546.168074788733, 5547.667139971614, 5568.359638641527, 5571.9442805571425, 5623.297087864017, 5671.829845104653, 5681.062624666966, 5762.654240745569, 5532.446755324436, 5538.723063846792, 5545.390007099297, 5555.611107222537, 5565.721713914288, 4966.701997880139, 4974.850754477371, 4977.427595826454, 4979.327790748275, 5001.874953126201, 5775.595708300462, 5816.651000939957, 5944.524438045032, 6034.909476357858, 6043.758249670052, 5767.307923049093, 5808.970955145197, 5826.096954971986, 5834.824955251349, 5839.854003649943, 6053.334133245251, 6058.242719660043, 6060.727267273071, 6065.363136870565, 6067.757289708362, 5508.256385388082, 5533.197686335539, 5737.225474561048, 5747.9137812932, 5757.0, 5756.913646295226, 5814.709264536841, 5825.563082768725, 5883.117532370179, 5899.203607513103, 5717.971410142923, 5724.914126288026, 5725.51333136688, 5729.255196824386, 5730.455606717355, 5590.440955904377, 5720.942790572041, 5724.198612194213, 5735.541156707537, 5742.483176514133, 5477.972610136924, 5537.280153580009, 5588.776448941997, 5608.327000759935, 5652.63257888236, 5681.715914204356, 5713.714314284186, 5720.513756330759, 5738.942610573841, 5751.051076572486, 5421.945780542144, 5475.370332411823, 5478.068728316275, 5592.832215033555, 5613.46672066153], "value": 5344.553130343419, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.3667239381468, 613.7882430561456, 648.2059477140502, 657.224475119359, 668.6890595872918, 33718.83140584297, 44719.55280447195, 45571.77214113933, 45712.31431528526, 48665.27002094971, 45618.77190614051, 45960.77019614905, 46147.30779038317, 46208.53791462084, 46223.53776462243, 8771.868421973675, 8978.551072446351, 8990.28077753778, 8999.0, 9002.054784247657, 8878.911210887873, 8962.910370896272, 8970.416922900024, 8977.865332020025, 8980.41627294227, 9013.549322533847, 9050.275977921783, 9063.54682265884, 9073.727788166332, 9073.818523629556, 9006.279497640206, 9049.547522623843, 9050.185483306534, 9052.230560402406, 9060.229880460169, 8854.0, 8880.378373513857, 8905.332100092519, 8908.51003194824, 8930.955345223298, 43594.78202608998, 43990.340144897855, 44172.55827441749, 44253.114937701066, 44259.0, 3653.725970552193, 3674.2835147146316, 3702.747263661827, 3816.6755825754844, 3902.4341470486906, 32107.357852843044, 32300.676993230238, 32511.51232731487, 32771.34457310864, 34164.0, 4164.66682665386, 4237.364395340693, 4274.380214868826, 4317.503487098992, 4321.351797230409, 360559.0, 360632.0, 360776.9999999974, 361849.0, 362886.0, 38446.615533844866, 39577.60422395797, 60998.0, 61379.38620613826, 61403.38596614066, 40404.191916161515, 40429.19141617151, 40481.797591012444, 40524.39213411801, 40540.797296013334, 17375.04437255963, 17506.912465437592, 17515.38696145654, 17520.474385768448, 17551.385701500385, 14081.507147249797, 14127.434902603985, 14166.787498187536, 14185.0, 14194.716105677828, 9532.809343813224, 9550.092741189575, 9586.137247647606, 9632.27757918159, 9634.084761947604, 3572.7856328620364, 3579.910502237413, 3587.4260118380935, 3625.4743062255825, 3633.4913112164318, 1054.7732237568805, 1074.6346242277664, 1109.4951796932376, 1126.5099681638515, 1152.7233463968587, 31379.117252964894, 32559.83720081432, 33170.66829331724, 33225.501617475755, 33712.49431258533, 1100.3397961223202, 1126.301692950376, 1127.0926903842321, 1138.0099313597223, 1138.4933704501582, 13046.282454465096, 15699.372025119095, 19103.140358683893, 19196.90401548011, 19554.217831286875, 543580.0, 547647.0, 547954.0, 548084.0, 548572.0, 63442.0, 63847.6807615959, 64039.0, 64073.67963160248, 64093.0, 1310.5740634293702, 1356.4438580182077, 1377.7037936843426, 1398.930053497321, 1408.7816388459805, 30723.0, 34476.13809654779, 34556.481652774724, 34572.481412778325, 34774.65225347714, 53080.0, 53346.73326633342, 53495.0, 53745.0, 53792.731036344565, 390103.0, 391059.0, 392317.0, 394014.0, 394211.0, 30063.0, 30784.0, 30983.535246971765, 31274.687253127177, 32426.189345265615, 49090.75454622704, 50101.74949125231, 50103.24845127399, 50224.24663630121, 51219.74390128026, 40118.799406002785, 41576.376354354106, 42113.36829947492, 42250.0, 42342.36486452767, 41725.165496690504, 41739.0, 42407.0, 43720.0, 43940.78029609832, 41072.589274106875, 41628.0, 42700.572994269656, 42760.572394276904, 42896.0, 34274.48588271228, 37206.46538578831, 37366.626333737404, 37449.251014980095, 38139.80930095332, 28575.571366429103, 29065.418691626473, 29104.854475727487, 29132.1260362181, 29142.708572913998], "value": 19613.368131981697, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.16394350457244, 426.24341793316876, 432.070080382832, 433.9067100573377, 437.34398402396414, 15325.846741532581, 19112.61774764504, 19506.99999999998, 20563.28028519002, 20758.48103797402, 19605.901970490162, 19827.21317835241, 19922.203111875544, 20118.497037574067, 20314.69527957078, 5657.0665840136435, 5894.056950887859, 5896.0, 5899.410058994109, 5911.497522710575, 5637.492625663689, 5742.79900203493, 5791.855203619923, 5802.013657678183, 5810.15752715856, 5768.423157684219, 5773.307203135609, 5774.191613174159, 5779.884402311951, 5782.335031471372, 5582.385937546866, 5787.565932555054, 5791.333996590404, 5798.942010579904, 5808.941910580882, 5076.923846142311, 5217.869553261199, 5244.554212891909, 5253.106971814763, 5255.710935898524, 23665.645015324782, 23863.52272954531, 23989.160379386813, 24062.398440038964, 24206.273811785675, 2450.546648869947, 2619.0702300683174, 2798.776097912162, 2853.9001134960176, 2876.266552029219, 14336.42654293827, 14562.563123106323, 14968.70062598742, 15076.547703568911, 15087.396504139931, 1919.4433614251989, 1994.9301774437824, 2004.2584243829876, 2043.1725151313592, 2077.3975547091477, 54134.0, 54440.0, 54607.72696136533, 78693.60653196754, 89395.10604893933, 10179.18566514677, 11149.108071354272, 11325.603603873826, 11367.374794386224, 11438.656840294805, 15623.531294061197, 15873.0, 15907.761383579256, 15910.204489775464, 15919.124448155462, 7481.177070522238, 7863.056433228049, 8454.87317690235, 8579.14208579137, 8699.695510657224, 7936.3254123399, 8208.794780130545, 8525.829483410422, 8668.91331086681, 8775.561221938877, 6819.693113809891, 6916.135483064617, 7055.435565154775, 7057.400120989773, 7103.360697537143, 1932.8260456558978, 2014.5165160361407, 2018.132203152629, 2026.5136367271748, 2094.3245403676997, 462.50973967593785, 465.6461089571882, 956.7416797464784, 1068.3429690740138, 1093.1091160704, 12421.937890310672, 12560.371981400893, 13037.869621303666, 13042.54351097726, 13096.476140954446, 449.42256160917117, 461.186006698178, 463.406839245766, 484.1503161950754, 524.29744142848, 6846.520743548003, 6988.196357418962, 6993.2657071007825, 7024.578525288499, 7197.676104575306, 439231.0, 457450.0, 467143.0, 471890.0, 472016.0, 95652.0, 97053.51473242589, 98606.0, 99125.50437247912, 100671.0, 1029.5572903651353, 1032.2155162076876, 1065.7175848400025, 1069.7004838645191, 1077.9299345542358, 17563.82436175622, 17911.73132403041, 18025.0, 18096.547586310448, 18478.81521184771, 29636.0, 38605.0, 39270.803645981585, 42825.143497130506, 43020.35469467898, 55739.72130139486, 56075.15887261776, 57120.0, 57576.71211643915, 57940.420595793505, 9000.144986226298, 9059.547022648972, 9086.818263634823, 9126.954365228132, 9129.5891684873, 9462.668806591737, 9510.09654082861, 9683.128518433376, 10015.14871235953, 10268.024537668909, 8313.584320783815, 8393.706220282262, 8563.871541927001, 8886.644534218558, 9050.140236677506, 8629.180227878342, 8869.334799889904, 8876.644934202817, 8964.596593153194, 9078.727638170865, 5609.439056094521, 8245.051819040887, 8478.957605211934, 8729.869051964099, 8788.736337909873, 12537.373131343578, 12556.121071524905, 12821.166624169398, 12880.098393112392, 13048.217106973612, 12223.327716975651, 12265.141440099107, 12547.372631368578, 12599.748005040032, 12929.806052909025], "value": 8840.636042088909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.1554298506865, 1483.4956114920928, 1648.90930998795, 1745.6334169824336, 1810.2939853457153, 8443.746687599374, 9005.819883602324, 9007.459552426859, 9007.504587247715, 9016.09839016098, 7821.256980586835, 8082.95958520208, 8186.345092392609, 8536.359773017017, 8817.250533704642, 2477.7770000699934, 2539.428628558578, 2541.4535874786916, 2542.7838633716156, 2544.0, 2466.8149888758326, 2498.71264804548, 2511.4223728542447, 2519.231634351522, 2542.211914306571, 2465.3097132802845, 2469.1851688942697, 2497.4880149569385, 2498.2380373985925, 2498.575242208829, 2380.9642855357183, 2382.011465241931, 2387.7492863249454, 2400.0, 2406.5066661334386, 2331.8367714260007, 2380.19073515004, 2401.915932942356, 2404.2787163850776, 2485.2792690119845, 8756.211940925283, 8869.423487473294, 8892.199702026785, 8914.108589141098, 8927.553622318923, 5428.104362780136, 5560.499555040025, 5562.332520097574, 5570.080936645449, 5572.60991730579, 3392.5080863274934, 3403.540522029544, 3458.8443520041405, 3576.088097535138, 3605.5132557104716, 1213.7269114449177, 1223.0276929840797, 1238.3374894431527, 1254.6424269083268, 1313.4943046926905, 12246.755064898653, 12539.18495297812, 12539.811902821464, 12557.0, 12602.369881505889, 4772.7136371817105, 4945.752712364368, 4952.653314268039, 5012.270766585595, 5113.74431278442, 10311.175105991502, 10324.0, 10333.896661033294, 10338.948305258577, 10339.276250662382, 5608.85977850557, 5610.887782244332, 5632.155176723524, 5642.548596112301, 5647.322321321386, 4381.364702118175, 4692.343071969927, 4945.975270123627, 5039.596832253411, 5097.108006098918, 4268.16770729711, 4324.870253892388, 4364.236258654722, 4397.098594788061, 4407.537208593116, 1400.4258254115764, 1417.9149251044971, 1420.4176287721984, 1435.3756116089535, 1453.077295917079, 881.352206128495, 899.8560230363241, 940.2478017585904, 963.1428029054148, 979.1579241852002, 5780.710964451845, 5903.645781253139, 5907.025340818803, 6010.9699451502465, 6147.415995480422, 450.83544506255635, 452.50902770493724, 495.511920758053, 496.5183771741405, 500.13975961346426, 3823.3118038752737, 3829.3298672732717, 3870.651641352292, 3992.8203230854683, 4098.877033688994, 10272.178225741924, 10715.410652414192, 10900.182486313399, 10901.182411319025, 10923.0, 10334.896651033394, 10836.566537338418, 10836.891631083747, 10844.295120817122, 10854.185936054828, 8009.959950200212, 8480.448770829877, 8481.703140390056, 8483.830323393497, 8485.448445850876, 5899.115132729953, 5954.821355359346, 6006.429389208193, 6021.548383871314, 6094.451499365078, 9674.467904265051, 9724.076212759777, 9854.359466634645, 9913.801723965624, 9966.302358835102, 10092.192624590161, 10132.696019119438, 10209.54057067419, 10221.795564088528, 10229.744256393353, 7284.599347035964, 7497.850042999218, 7623.123340815655, 8050.597470126588, 8202.917970820215, 8426.41015128935, 8803.427777194718, 8826.029136795076, 8831.779205519913, 8831.779205519913, 7885.329746971572, 7932.365410767009, 7960.124386317616, 8037.115917249215, 8188.303994160563, 7574.431917606092, 7648.235176482307, 7726.6136693166245, 7852.646630901509, 7854.1360450349275, 7159.785206443815, 7195.208527062124, 7259.491835571459, 7268.41852651776, 7360.0, 5274.446183150714, 5385.784568617368, 5397.433269506645, 5412.512873841373, 5506.614536982373, 5243.213517972335, 5287.735613219401, 5326.385730388158, 5378.300820893259, 5417.0], "value": 4678.5491020085365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.3639258512433, 359.4356859730224, 360.4143267190815, 368.55957131228195, 376.27003612990814, 5258.868528286795, 5282.89434211316, 5307.920381194275, 5322.361316642008, 5359.678419294845, 5232.319798426209, 5240.423553409122, 5246.737663116838, 5252.317198764155, 5264.499872512105, 3937.8973887311527, 4064.0, 4069.125138095309, 4126.752394856303, 4245.872623821275, 4167.145735124307, 4177.3290683726445, 4220.53574106848, 4223.809928553207, 4234.491860976687, 4154.52222994355, 4165.875023749292, 4174.561671024544, 4178.122594255195, 4202.621764041236, 3919.451276821247, 4010.8596199133035, 4129.256733787917, 4170.47869016373, 4202.642775364097, 3729.5710993235584, 3730.253949210142, 3731.7201209909367, 3738.2897249522503, 3810.618938106195, 5133.793558513747, 5139.486051394868, 5148.3564554430695, 5149.588032957355, 5171.534561889448, 4500.729956202638, 4695.765211739399, 4700.1539722849875, 4753.191957367256, 4758.452777930548, 5403.918941215885, 5433.1850222466555, 5437.429069947638, 5441.428649991733, 5455.481729235717, 3872.341701910682, 4042.7170098093147, 4059.5534491205945, 4076.1440097579543, 4106.958930410688, 5628.887422251573, 5640.915386269209, 5700.743466543974, 5708.571857110734, 5710.944060138347, 4061.045654271244, 4066.3290557058344, 4083.693722970789, 4091.509018917749, 4100.6831140406175, 4161.334186530201, 4172.7704976226, 4181.686373521998, 4182.623563879265, 4186.513787605356, 4541.205289074399, 4691.483936766953, 4721.527847215251, 4725.291206319011, 4747.074320507537, 5588.524975377139, 5595.804146854841, 5609.158626206102, 5620.381758006616, 5622.943770562324, 1389.7567925612977, 1394.979075313851, 1400.2998500749625, 1403.9540542295852, 1405.8313002439568, 957.129012598546, 986.6842610364758, 992.1764935103846, 998.6205242008135, 1006.8540061691014, 5161.974190129025, 5281.577473802164, 5283.471652834763, 5322.54758345545, 5323.254744335796, 5624.3813180550105, 5627.943720562824, 5637.830865074055, 5645.915311270334, 5653.434656534314, 5255.369355677343, 5340.759665815048, 5341.946580534222, 5380.139177731622, 5401.540869026098, 2848.61543691599, 2879.481693295227, 2893.7122980273575, 2895.5077636801793, 2899.1012786036395, 5649.615844118135, 5681.971590142106, 5701.315842098975, 5710.314762228476, 5714.942850571524, 5344.412114667383, 5588.491107401061, 5592.5738936570915, 5619.634723742944, 5623.971880140573, 5647.672796892727, 5684.8010319638615, 5704.3725190228215, 5713.657180569179, 5720.856978575569, 5213.76538055796, 5446.210299506629, 5496.230527726041, 5506.311711036121, 5543.833684989457, 5375.274337964481, 5395.622306438511, 5411.83764487066, 5413.079776437936, 5427.375851777097, 5696.401877802937, 5703.714814259353, 5721.656700597978, 5752.382665887095, 5809.767609295581, 3925.862594809168, 4001.0, 4022.6580740637373, 4073.6537394321813, 4178.874633760992, 5592.217089607377, 5599.272094627672, 5623.212750215055, 5641.40765219646, 5646.3506696728755, 5544.0318686865585, 5549.916751248816, 5567.4432556744005, 5618.550515958632, 5625.268715067015, 5331.3129903402105, 5487.560995120461, 5489.560835133259, 5528.170774383874, 5549.390676703711, 5473.522149019663, 5486.890262194654, 5487.890242195213, 5491.869634308406, 5523.7790488380015, 5342.305500284938, 5477.1510415885605, 5494.0, 5511.283533140666, 5570.777168913198, 5440.42875498067, 5442.6462279951675, 5454.154606036071, 5455.817672930701, 5467.4532546745], "value": 4221.773649491582, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.8323360477497, 795.4193438789683, 803.6664784114593, 826.0170397227299, 857.8841856349393, 14706.852931470683, 15638.296276667548, 15701.92149039256, 15823.0, 16128.354865805353, 14322.57032289033, 14554.490592829254, 14684.045537040085, 14868.628284292898, 14875.702485950274, 712.3197346534048, 834.2783492279165, 848.0755975986174, 848.3933987199151, 848.5502683577714, 711.1679335177854, 833.0544831616129, 849.3841964575695, 851.7955690634234, 857.2798848966867, 900.8828852249198, 902.2736696958946, 904.2133343990737, 905.2215095018279, 905.8595917632745, 729.8394353242278, 897.5915958238986, 897.6499165325529, 897.7845317123908, 897.9551022448884, 548.5803360429275, 633.5185259203039, 650.9707063182168, 652.4747578199548, 658.8649326887977, 13976.371063302075, 14019.43922243109, 14054.578362649137, 14068.296585170701, 14075.648108797259, 14018.92990535051, 14078.436862525487, 14134.15195088298, 14211.857881421156, 14363.856361436356, 13067.411966461437, 13100.86899131006, 13165.275909824955, 13236.404361803741, 13282.601521954357, 4405.207062728708, 4413.713108647928, 4466.977665111686, 4497.9775101124615, 4509.977450112761, 53165.46834531644, 53702.19446708341, 58995.0, 64994.0, 65321.346786532, 11661.300321980709, 11902.523899043941, 11956.641300760992, 12065.517379304905, 12161.966232870305, 20406.0, 20498.897505512377, 20635.69046464304, 21127.8943605281, 21132.57734845325, 7829.29536341732, 8105.067917189481, 8166.387520935835, 8173.060098088796, 8193.46742461738, 4329.242382583036, 4405.581469760367, 4407.911841763147, 4539.0, 4551.226291530382, 3570.732195085379, 3702.4631428442726, 3705.6850167735506, 3713.5729391120367, 3718.4236443351324, 599.1073300781803, 608.7473698415197, 624.2727222785404, 640.6732566391081, 645.2934037229227, 705.5590256089944, 728.2135293882594, 751.8533885892308, 785.5836406704456, 788.6411682684364, 9433.29250306216, 9877.506124693737, 10094.949525252327, 10185.439800811026, 10357.74105647365, 760.9809754756176, 775.8138046868711, 779.516699646223, 785.2461636828594, 811.338758911497, 4609.492955774862, 4931.654784165074, 5032.295478632995, 5049.671771334852, 5166.689998600096, 56101.7194914031, 60186.0, 66432.6678366605, 94147.0, 94316.52841735748, 79142.0, 79411.60294198607, 81138.0, 81344.0, 84790.57604711936, 71729.2827071733, 74475.62762186154, 75040.62479687567, 75872.24127758761, 76343.23656763473, 9566.521673916137, 9815.705528834147, 9868.703938881845, 9955.452450115314, 10003.599856005969, 48412.273815892084, 48962.755186225266, 49404.0, 49657.25514117219, 50778.79290837414, 64771.67614161899, 65356.0, 67729.3227067723, 68535.31464685289, 69408.30591694018, 11481.311121332747, 11989.460474278503, 12833.807492887801, 13051.738965220833, 13063.412146453622, 13523.323833808467, 13785.586432407044, 13837.654058648613, 14041.438342466596, 14185.432582696989, 13002.739945200854, 13010.609681709564, 13025.934870325587, 14060.78908816389, 14063.789043164155, 13006.934965325112, 13052.869471305165, 13348.666283342605, 13596.66008349799, 13612.251326177155, 12346.938265308616, 12907.741845163231, 13235.933820331222, 13257.867421325664, 13596.11625244356, 10796.298240614335, 10808.351498910091, 11005.559777609125, 11419.486123124314, 11640.185187036826, 11020.338779673246, 11039.337639741641, 11307.547698091985, 11377.829332560184, 11414.942925285653], "value": 7394.078946452797, "unit": "score"}], "name": "dromaeo_css", "value": 7165.504403304924, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 112.0, 110.0, 112.0, 111.0, 113.0, 112.0, 113.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 126.0, 152.0, 130.0, 123.0, 125.0, 120.0, 148.0, 127.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 162.0, 160.0, 160.0, 161.0, 163.0, 160.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 113.0, 76.0, 76.0, 75.0, 76.0, 98.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 122.0, 82.0, 82.0, 82.0, 101.0, 83.0, 82.0, 117.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 51.0, 50.0, 51.0, 51.0, 51.0, 50.0, 51.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 59.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 80.0, 84.0, 77.0, 88.0, 75.0, 75.0, 75.0, 74.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 127.0, 128.0, 135.0, 131.0, 147.0, 133.0, 132.0, 165.0, 136.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 160.0, 164.0, 156.0, 161.0, 158.0, 158.0, 155.0, 154.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 69.0, 63.0, 68.0, 62.0, 65.0, 62.0, 61.0, 61.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1474.4, "alertThreshold": 2.0}]} 08:03:39 INFO - Return code: 0 08:03:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:03:39 ERROR - # TBPL SUCCESS # 08:03:39 INFO - Running post-action listener: _resource_record_post_action 08:03:39 INFO - [mozharness: 2016-11-14 16:03:39.352707Z] Finished run-tests step (success) 08:03:39 INFO - Running post-run listener: _resource_record_post_run 08:03:39 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 361320448; Read time: 16; Write time: 190796 08:03:39 INFO - TinderboxPrint: CPU usage
13.0% 08:03:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:03:39 INFO - TinderboxPrint: I/O write bytes / time
361,320,448 / 190,796 08:03:39 INFO - TinderboxPrint: CPU idle
8,278.6 (87.0%) 08:03:39 INFO - TinderboxPrint: CPU user
1,190.2 (12.5%) 08:03:39 INFO - TinderboxPrint: Swap in / out
0 / 0 08:03:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114913280; Read time: 0; Write time: 81460 08:03:39 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 245919744; Read time: 0; Write time: 109332 08:03:39 INFO - Running post-run listener: _upload_blobber_files 08:03:39 INFO - Blob upload gear active. 08:03:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:03:39 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 08:03:39 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:03:39 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:03:40 INFO - (blobuploader) - INFO - Open directory for files ... 08:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:03:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:43 INFO - (blobuploader) - INFO - Done attempting. 08:03:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:03:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:03:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:44 INFO - (blobuploader) - INFO - Done attempting. 08:03:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:03:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:03:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:44 INFO - (blobuploader) - INFO - Done attempting. 08:03:44 INFO - (blobuploader) - INFO - Iteration through files over. 08:03:44 INFO - Return code: 0 08:03:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:03:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:03:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/469d1e4d3a7dc5c2718595d805fe23d765d771f16eb051deef3d5d5fbe5c45921bd50b74fd1143d90cdc8323ca9e1c283cc4cf2b983d13ffdec7944c520d7024", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/991bea21b7bcc79e2cfcb345f1eff162c0f6d58d9ad4a06a4eb7212453b8de92c1aa1715eebf613b5a6ac3509edcedd11388ed1cabe5d0ccf46c1a44519dec3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f23e7d7170be390d2c98eb439ec0bef4841e2ebcd151c086125df9ab4735adfa3f227c51e851b753dc521bdf66d218acec226e517fb6a9ff944e59b25fa65ef7"} 08:03:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:03:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:03:44 INFO - Contents: 08:03:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/469d1e4d3a7dc5c2718595d805fe23d765d771f16eb051deef3d5d5fbe5c45921bd50b74fd1143d90cdc8323ca9e1c283cc4cf2b983d13ffdec7944c520d7024", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/991bea21b7bcc79e2cfcb345f1eff162c0f6d58d9ad4a06a4eb7212453b8de92c1aa1715eebf613b5a6ac3509edcedd11388ed1cabe5d0ccf46c1a44519dec3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f23e7d7170be390d2c98eb439ec0bef4841e2ebcd151c086125df9ab4735adfa3f227c51e851b753dc521bdf66d218acec226e517fb6a9ff944e59b25fa65ef7"} 08:03:44 INFO - Running post-run listener: copy_logs_to_upload_dir 08:03:44 INFO - Copying logs to upload dir... 08:03:44 INFO - mkdir: /builds/slave/test/build/upload/logs 08:03:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.830450 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-14 08:03:41.868165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 08:03:41.871424) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511 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-Aurora/sha512/469d1e4d3a7dc5c2718595d805fe23d765d771f16eb051deef3d5d5fbe5c45921bd50b74fd1143d90cdc8323ca9e1c283cc4cf2b983d13ffdec7944c520d7024", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/991bea21b7bcc79e2cfcb345f1eff162c0f6d58d9ad4a06a4eb7212453b8de92c1aa1715eebf613b5a6ac3509edcedd11388ed1cabe5d0ccf46c1a44519dec3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f23e7d7170be390d2c98eb439ec0bef4841e2ebcd151c086125df9ab4735adfa3f227c51e851b753dc521bdf66d218acec226e517fb6a9ff944e59b25fa65ef7"} build_url:https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011605 build_url: 'https://queue.taskcluster.net/v1/task/M5rldo1ERxmFyrJ2M3IHUg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/469d1e4d3a7dc5c2718595d805fe23d765d771f16eb051deef3d5d5fbe5c45921bd50b74fd1143d90cdc8323ca9e1c283cc4cf2b983d13ffdec7944c520d7024", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/991bea21b7bcc79e2cfcb345f1eff162c0f6d58d9ad4a06a4eb7212453b8de92c1aa1715eebf613b5a6ac3509edcedd11388ed1cabe5d0ccf46c1a44519dec3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f23e7d7170be390d2c98eb439ec0bef4841e2ebcd151c086125df9ab4735adfa3f227c51e851b753dc521bdf66d218acec226e517fb6a9ff944e59b25fa65ef7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 08:03:41.896894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 08:03:41.897236) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1479138187.345315-819158511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 08:03:41.980103) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 08:03:41.980427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 08:03:41.980758) ========= ========= Total master_lag: 0.15 =========