builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1482816762.57 results: success (0) buildid: 20161226195737 builduid: fde98cd84a6c47e3977d73872bcf3c6c revision: 5434909ba45c6df65a4e769ba80fe67ead95b785 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:42.568474) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:42.568908) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:42.569217) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:42.614699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:42.615005) ========= 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=62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-26 21:32:43-- 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% 61.7K=0.2s 2016-12-26 21:32:43 (61.7 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.293046 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:42.922345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:42.925760) ========= 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=62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020562 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:42.975320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:42.978716) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5434909ba45c6df65a4e769ba80fe67ead95b785 --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 5434909ba45c6df65a4e769ba80fe67ead95b785 --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=62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-26 21:32:43,949 truncating revision to first 12 chars 2016-12-26 21:32:43,949 Setting DEBUG logging. 2016-12-26 21:32:43,949 attempt 1/10 2016-12-26 21:32:43,949 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5434909ba45c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-26 21:32:44,242 unpacking tar archive at: mozilla-aurora-5434909ba45c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619828 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:43.612386) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:43.612709) ========= script_repo_revision: 5434909ba45c6df65a4e769ba80fe67ead95b785 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:43.613096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:43.613362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-26 21:32:43.625734) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-26 21:32:43.626049) ========= /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=62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:32:44 INFO - MultiFileLogger online at 20161226 21:32:44 in /builds/slave/test 21:32:44 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 21:32:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:32:44 INFO - {'append_to_log': False, 21:32:44 INFO - 'base_work_dir': '/builds/slave/test', 21:32:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:32:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:32:44 INFO - 'branch': 'Mozilla-Aurora', 21:32:44 INFO - 'buildbot_json_path': 'buildprops.json', 21:32:44 INFO - 'config_files': ('talos/linux_config.py',), 21:32:44 INFO - 'default_actions': ('clobber', 21:32:44 INFO - 'read-buildbot-config', 21:32:44 INFO - 'download-and-extract', 21:32:44 INFO - 'populate-webroot', 21:32:44 INFO - 'create-virtualenv', 21:32:44 INFO - 'install', 21:32:44 INFO - 'run-tests'), 21:32:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:32:44 INFO - 'download_minidump_stackwalk': True, 21:32:44 INFO - 'download_symbols': 'ondemand', 21:32:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:32:44 INFO - 'tooltool.py': '/tools/tooltool.py', 21:32:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:32:44 INFO - '/tools/misc-python/virtualenv.py')}, 21:32:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:32:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:32:44 INFO - 'installer_path': 'installer.exe', 21:32:44 INFO - 'log_level': 'info', 21:32:44 INFO - 'log_name': 'talos', 21:32:44 INFO - 'log_to_console': True, 21:32:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:32:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:32:44 INFO - 'opt_config_files': (), 21:32:44 INFO - 'pip_index': False, 21:32:44 INFO - 'sps_profile': False, 21:32:44 INFO - 'sps_profile_interval': 0, 21:32:44 INFO - 'suite': 'dromaeojs', 21:32:44 INFO - 'system_bits': '32', 21:32:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:32:44 INFO - 'title': 'talos-linux64-ix-018', 21:32:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:32:44 INFO - 'use_talos_json': True, 21:32:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:32:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:32:44 INFO - 'work_dir': 'build'} 21:32:44 INFO - [mozharness: 2016-12-27 05:32:44.697040Z] Running clobber step. 21:32:44 INFO - Running pre-action listener: _resource_record_pre_action 21:32:44 INFO - Running main action method: clobber 21:32:44 INFO - rmtree: /builds/slave/test/build 21:32:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:32:45 INFO - Running post-action listener: _resource_record_post_action 21:32:45 INFO - [mozharness: 2016-12-27 05:32:45.160993Z] Finished clobber step (success) 21:32:45 INFO - [mozharness: 2016-12-27 05:32:45.161093Z] Running read-buildbot-config step. 21:32:45 INFO - Running pre-action listener: _resource_record_pre_action 21:32:45 INFO - Running main action method: read_buildbot_config 21:32:45 INFO - Using buildbot properties: 21:32:45 INFO - { 21:32:45 INFO - "project": "", 21:32:45 INFO - "product": "firefox", 21:32:45 INFO - "script_repo_revision": "production", 21:32:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:32:45 INFO - "repository": "", 21:32:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:32:45 INFO - "buildid": "20161226195737", 21:32:45 INFO - "pgo_build": "True", 21:32:45 INFO - "basedir": "/builds/slave/test", 21:32:45 INFO - "buildnumber": 660, 21:32:45 INFO - "slavename": "talos-linux64-ix-018", 21:32:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:32:45 INFO - "platform": "ubuntu64_hw", 21:32:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:32:45 INFO - "branch": "mozilla-aurora", 21:32:45 INFO - "repo_path": "releases/mozilla-aurora", 21:32:45 INFO - "revision": "5434909ba45c6df65a4e769ba80fe67ead95b785", 21:32:45 INFO - "stage_platform": "linux64-pgo", 21:32:45 INFO - "builduid": "fde98cd84a6c47e3977d73872bcf3c6c", 21:32:45 INFO - "slavebuilddir": "test" 21:32:45 INFO - } 21:32:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 21:32:45 INFO - Running post-action listener: _resource_record_post_action 21:32:45 INFO - [mozharness: 2016-12-27 05:32:45.163568Z] Finished read-buildbot-config step (success) 21:32:45 INFO - [mozharness: 2016-12-27 05:32:45.163654Z] Running download-and-extract step. 21:32:45 INFO - Running pre-action listener: _resource_record_pre_action 21:32:45 INFO - Running main action method: download_and_extract 21:32:45 INFO - mkdir: /builds/slave/test/build/tests 21:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:45 INFO - trying https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 21:32:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/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 21:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/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 21:32:45 INFO - Downloaded 1361 bytes. 21:32:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 21:32:45 INFO - Using the following test package requirements: 21:32:45 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 21:32:45 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:32:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:32:45 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:32:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:32:45 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:32:45 INFO - u'jsshell-linux-x86_64.zip'], 21:32:45 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:32:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:32:45 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 21:32:45 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:32:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:32:45 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:32:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:32:45 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:32:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:32:45 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:32:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:32:45 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:32:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 21:32:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:32:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:32:46 INFO - Http code: 200 21:32:46 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 21:32:46 INFO - x-amz-cf-id: DhvcAgUB0hlsOKIy3R9wrS9MgpPUumw0lUDq-nZen4NzRDsQZN6X6A== 21:32:46 INFO - x-amz-version-id: TZwzUj.ejpV6Nxwiqlrnf6M03UHWK4qq 21:32:47 INFO - Expected file size: 21941650 21:32:47 INFO - Obtained file size: 21941650 21:32:51 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 21:32:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 21:32:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:32:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:32:51 INFO - Http code: 200 21:32:51 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 21:32:51 INFO - x-amz-cf-id: Duf1pehG3U8D8lDJR3-uxEfGM22Jq3nKjungqI5nwFygxUsQmmdN4w== 21:32:51 INFO - x-amz-version-id: TZwzUj.ejpV6Nxwiqlrnf6M03UHWK4qq 21:32:51 INFO - Expected file size: 21941650 21:32:51 INFO - Obtained file size: 21941650 21:32:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 21:32:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:32:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 21:32:56 INFO - Http code: 200 21:32:56 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 21:32:56 INFO - x-amz-cf-id: o3RkBy6FM4pT1QJGek0aAd5z36iYb6mT75_zcrjbKS_SMK6_eBZAWg== 21:32:56 INFO - x-amz-version-id: BDCmG.5qAUce9e0QScCBNlGrc4NgHr8Q 21:32:57 INFO - Expected file size: 14409038 21:32:57 INFO - Obtained file size: 14409038 21:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:58 INFO - trying https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:32:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/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 21:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/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 21:33:00 INFO - Downloaded 64012713 bytes. 21:33:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:33:00 INFO - mkdir: /builds/slave/test/properties 21:33:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:33:00 INFO - Writing to file /builds/slave/test/properties/build_url 21:33:00 INFO - Contents: 21:33:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:33:01 INFO - Running post-action listener: _resource_record_post_action 21:33:01 INFO - Running post-action listener: set_extra_try_arguments 21:33:01 INFO - [mozharness: 2016-12-27 05:33:01.282735Z] Finished download-and-extract step (success) 21:33:01 INFO - [mozharness: 2016-12-27 05:33:01.282964Z] Running populate-webroot step. 21:33:01 INFO - Running pre-action listener: _resource_record_pre_action 21:33:01 INFO - Running main action method: populate_webroot 21:33:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:33:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:33:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:33:01 INFO - '--tppagecycles', 21:33:01 INFO - '7'], 21:33:01 INFO - 'tests': ['tsvgm']}}, 21:33:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:33:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:33:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:33:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:33:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:01 INFO - 'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:33:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:33:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:01 INFO - 'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['damp', 'tps']}, 21:33:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:01 INFO - 'tests': ['damp', 'tps']}, 21:33:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['dromaeo_dom']}, 21:33:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:33:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['basic_compositor_video']}, 21:33:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:33:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['a11yr', 21:33:01 INFO - 'ts_paint', 21:33:01 INFO - 'tpaint', 21:33:01 INFO - 'sessionrestore', 21:33:01 INFO - 'sessionrestore_no_auto_restore', 21:33:01 INFO - 'tabpaint']}, 21:33:01 INFO - 'other-e10s': {'tests': ['a11yr', 21:33:01 INFO - 'ts_paint', 21:33:01 INFO - 'tpaint', 21:33:01 INFO - 'sessionrestore', 21:33:01 INFO - 'sessionrestore_no_auto_restore', 21:33:01 INFO - 'tabpaint']}, 21:33:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:33:01 INFO - 'ts_paint', 21:33:01 INFO - 'tpaint', 21:33:01 INFO - 'sessionrestore', 21:33:01 INFO - 'sessionrestore_no_auto_restore', 21:33:01 INFO - 'tabpaint']}, 21:33:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:33:01 INFO - 'ts_paint', 21:33:01 INFO - 'tpaint', 21:33:01 INFO - 'sessionrestore', 21:33:01 INFO - 'sessionrestore_no_auto_restore', 21:33:01 INFO - 'tabpaint']}, 21:33:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['a11yr', 21:33:01 INFO - 'ts_paint', 21:33:01 INFO - 'tpaint', 21:33:01 INFO - 'sessionrestore', 21:33:01 INFO - 'sessionrestore_no_auto_restore', 21:33:01 INFO - 'tabpaint']}, 21:33:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['a11yr', 21:33:01 INFO - 'ts_paint', 21:33:01 INFO - 'tpaint', 21:33:01 INFO - 'sessionrestore', 21:33:01 INFO - 'sessionrestore_no_auto_restore', 21:33:01 INFO - 'tabpaint']}, 21:33:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['tsvgx', 21:33:01 INFO - 'tsvgr_opacity', 21:33:01 INFO - 'tart', 21:33:01 INFO - 'tscrollx', 21:33:01 INFO - 'cart']}, 21:33:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:33:01 INFO - 'tsvgr_opacity', 21:33:01 INFO - 'tart', 21:33:01 INFO - 'tscrollx', 21:33:01 INFO - 'cart']}, 21:33:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:01 INFO - 'talos_options': ['--disable-e10s'], 21:33:01 INFO - 'tests': ['tp5o']}, 21:33:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:01 INFO - 'tests': ['tp5o']}, 21:33:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:01 INFO - 'talos_options': ['--disable-e10s', 21:33:01 INFO - '--xperf_path', 21:33:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:33:01 INFO - 'tests': ['tp5n']}, 21:33:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:33:01 INFO - 'talos_options': ['--xperf_path', 21:33:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:33:01 INFO - 'tests': ['tp5n']}}, 21:33:01 INFO - 'talos.zip': {'path': '', 21:33:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:33:01 INFO - Running post-action listener: _resource_record_post_action 21:33:01 INFO - [mozharness: 2016-12-27 05:33:01.307690Z] Finished populate-webroot step (success) 21:33:01 INFO - [mozharness: 2016-12-27 05:33:01.307779Z] Running create-virtualenv step. 21:33:01 INFO - Running pre-action listener: _resource_record_pre_action 21:33:01 INFO - Running main action method: create_virtualenv 21:33:01 INFO - Creating virtualenv /builds/slave/test/build/venv 21:33:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:33:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:33:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:33:01 INFO - Using real prefix '/usr' 21:33:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:33:01 INFO - Installing distribute.............................................................................................................................................................................................done. 21:33:03 INFO - Installing pip.................done. 21:33:03 INFO - Return code: 0 21:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:33:04 INFO - Reading from file tmpfile_stdout 21:33:04 INFO - Output received: 21:33:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:33:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:04 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 0x7f8f1446df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, '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': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:33:04 INFO - Using env: {'DISPLAY': ':0', 21:33:04 INFO - 'HOME': '/home/cltbld', 21:33:04 INFO - 'LANG': 'en_US.UTF-8', 21:33:04 INFO - 'LANGUAGE': 'en_US:en', 21:33:04 INFO - 'LOGNAME': 'cltbld', 21:33:04 INFO - 'MAIL': '/var/mail/cltbld', 21:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:04 INFO - 'MOZ_NO_REMOTE': '1', 21:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:04 INFO - 'NO_EM_RESTART': '1', 21:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:04 INFO - 'PWD': '/builds/slave/test', 21:33:04 INFO - 'SHELL': '/bin/bash', 21:33:04 INFO - 'SHLVL': '1', 21:33:04 INFO - 'TERM': 'linux', 21:33:04 INFO - 'TMOUT': '86400', 21:33:04 INFO - 'USER': 'cltbld', 21:33:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:04 INFO - '_': '/tools/buildbot/bin/python'} 21:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:33:04 INFO - Cleaning up... 21:33:04 INFO - Return code: 0 21:33:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:04 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 0x7f8f1446df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, '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': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:33:04 INFO - Using env: {'DISPLAY': ':0', 21:33:04 INFO - 'HOME': '/home/cltbld', 21:33:04 INFO - 'LANG': 'en_US.UTF-8', 21:33:04 INFO - 'LANGUAGE': 'en_US:en', 21:33:04 INFO - 'LOGNAME': 'cltbld', 21:33:04 INFO - 'MAIL': '/var/mail/cltbld', 21:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:04 INFO - 'MOZ_NO_REMOTE': '1', 21:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:04 INFO - 'NO_EM_RESTART': '1', 21:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:04 INFO - 'PWD': '/builds/slave/test', 21:33:04 INFO - 'SHELL': '/bin/bash', 21:33:04 INFO - 'SHLVL': '1', 21:33:04 INFO - 'TERM': 'linux', 21:33:04 INFO - 'TMOUT': '86400', 21:33:04 INFO - 'USER': 'cltbld', 21:33:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:04 INFO - '_': '/tools/buildbot/bin/python'} 21:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:04 INFO - Downloading/unpacking psutil>=3.1.1 21:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:33:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:33:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:33:06 INFO - Installing collected packages: psutil 21:33:06 INFO - Running setup.py install for psutil 21:33:06 INFO - building 'psutil._psutil_linux' extension 21:33:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:33:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:33:06 INFO - building 'psutil._psutil_posix' extension 21:33:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:33:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:33:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:33:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:33:07 INFO - Successfully installed psutil 21:33:07 INFO - Cleaning up... 21:33:07 INFO - Return code: 0 21:33:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:07 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 0x7f8f1446df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, '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': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:33:07 INFO - Using env: {'DISPLAY': ':0', 21:33:07 INFO - 'HOME': '/home/cltbld', 21:33:07 INFO - 'LANG': 'en_US.UTF-8', 21:33:07 INFO - 'LANGUAGE': 'en_US:en', 21:33:07 INFO - 'LOGNAME': 'cltbld', 21:33:07 INFO - 'MAIL': '/var/mail/cltbld', 21:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:07 INFO - 'MOZ_NO_REMOTE': '1', 21:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:07 INFO - 'NO_EM_RESTART': '1', 21:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:07 INFO - 'PWD': '/builds/slave/test', 21:33:07 INFO - 'SHELL': '/bin/bash', 21:33:07 INFO - 'SHLVL': '1', 21:33:07 INFO - 'TERM': 'linux', 21:33:07 INFO - 'TMOUT': '86400', 21:33:07 INFO - 'USER': 'cltbld', 21:33:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:07 INFO - '_': '/tools/buildbot/bin/python'} 21:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:33:09 INFO - Installing collected packages: mozsystemmonitor 21:33:09 INFO - Running setup.py install for mozsystemmonitor 21:33:09 INFO - Successfully installed mozsystemmonitor 21:33:09 INFO - Cleaning up... 21:33:09 INFO - Return code: 0 21:33:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8f1446df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, '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': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:33:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:33:09 INFO - Using env: {'DISPLAY': ':0', 21:33:09 INFO - 'HOME': '/home/cltbld', 21:33:09 INFO - 'LANG': 'en_US.UTF-8', 21:33:09 INFO - 'LANGUAGE': 'en_US:en', 21:33:09 INFO - 'LOGNAME': 'cltbld', 21:33:09 INFO - 'MAIL': '/var/mail/cltbld', 21:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:09 INFO - 'MOZ_NO_REMOTE': '1', 21:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:09 INFO - 'NO_EM_RESTART': '1', 21:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:09 INFO - 'PWD': '/builds/slave/test', 21:33:09 INFO - 'SHELL': '/bin/bash', 21:33:09 INFO - 'SHLVL': '1', 21:33:09 INFO - 'TERM': 'linux', 21:33:09 INFO - 'TMOUT': '86400', 21:33:09 INFO - 'USER': 'cltbld', 21:33:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:09 INFO - '_': '/tools/buildbot/bin/python'} 21:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:09 INFO - Downloading/unpacking jsonschema==2.5.1 21:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:33:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:12 INFO - Downloading functools32-3.2.3-2.tar.gz 21:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:33:12 INFO - warning: no files found matching '*.txt' 21:33:12 INFO - no previously-included directories found matching 'build' 21:33:12 INFO - no previously-included directories found matching 'dist' 21:33:12 INFO - no previously-included directories found matching '.git*' 21:33:12 INFO - Installing collected packages: jsonschema, functools32 21:33:12 INFO - Running setup.py install for functools32 21:33:12 INFO - warning: no files found matching '*.txt' 21:33:12 INFO - no previously-included directories found matching 'build' 21:33:12 INFO - no previously-included directories found matching 'dist' 21:33:12 INFO - no previously-included directories found matching '.git*' 21:33:12 INFO - Successfully installed jsonschema functools32 21:33:12 INFO - Cleaning up... 21:33:12 INFO - Return code: 0 21:33:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:12 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 0x7f8f1446df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, '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': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:33:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:33:12 INFO - Using env: {'DISPLAY': ':0', 21:33:12 INFO - 'HOME': '/home/cltbld', 21:33:12 INFO - 'LANG': 'en_US.UTF-8', 21:33:12 INFO - 'LANGUAGE': 'en_US:en', 21:33:12 INFO - 'LOGNAME': 'cltbld', 21:33:12 INFO - 'MAIL': '/var/mail/cltbld', 21:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:12 INFO - 'MOZ_NO_REMOTE': '1', 21:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:12 INFO - 'NO_EM_RESTART': '1', 21:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:12 INFO - 'PWD': '/builds/slave/test', 21:33:12 INFO - 'SHELL': '/bin/bash', 21:33:12 INFO - 'SHLVL': '1', 21:33:12 INFO - 'TERM': 'linux', 21:33:12 INFO - 'TMOUT': '86400', 21:33:12 INFO - 'USER': 'cltbld', 21:33:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:12 INFO - '_': '/tools/buildbot/bin/python'} 21:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:33:12 INFO - Cleaning up... 21:33:12 INFO - Return code: 0 21:33:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:12 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 0x7f8f1446df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, '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': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:33:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:33:12 INFO - Using env: {'DISPLAY': ':0', 21:33:12 INFO - 'HOME': '/home/cltbld', 21:33:12 INFO - 'LANG': 'en_US.UTF-8', 21:33:12 INFO - 'LANGUAGE': 'en_US:en', 21:33:12 INFO - 'LOGNAME': 'cltbld', 21:33:12 INFO - 'MAIL': '/var/mail/cltbld', 21:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:12 INFO - 'MOZ_NO_REMOTE': '1', 21:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:12 INFO - 'NO_EM_RESTART': '1', 21:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:12 INFO - 'PWD': '/builds/slave/test', 21:33:12 INFO - 'SHELL': '/bin/bash', 21:33:12 INFO - 'SHLVL': '1', 21:33:12 INFO - 'TERM': 'linux', 21:33:12 INFO - 'TMOUT': '86400', 21:33:12 INFO - 'USER': 'cltbld', 21:33:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:12 INFO - '_': '/tools/buildbot/bin/python'} 21:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:12 INFO - Downloading/unpacking blobuploader==1.2.4 21:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:14 INFO - Downloading blobuploader-1.2.4.tar.gz 21:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:33:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:33:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:15 INFO - Downloading docopt-0.6.1.tar.gz 21:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:33:15 INFO - Installing collected packages: blobuploader, requests, docopt 21:33:15 INFO - Running setup.py install for blobuploader 21:33:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:33:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:33:15 INFO - Running setup.py install for requests 21:33:16 INFO - Running setup.py install for docopt 21:33:16 INFO - Successfully installed blobuploader requests docopt 21:33:16 INFO - Cleaning up... 21:33:16 INFO - Return code: 0 21:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:16 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 0x7f8f1446df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, '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': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:33:16 INFO - Using env: {'DISPLAY': ':0', 21:33:16 INFO - 'HOME': '/home/cltbld', 21:33:16 INFO - 'LANG': 'en_US.UTF-8', 21:33:16 INFO - 'LANGUAGE': 'en_US:en', 21:33:16 INFO - 'LOGNAME': 'cltbld', 21:33:16 INFO - 'MAIL': '/var/mail/cltbld', 21:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:16 INFO - 'MOZ_NO_REMOTE': '1', 21:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:16 INFO - 'NO_EM_RESTART': '1', 21:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:16 INFO - 'PWD': '/builds/slave/test', 21:33:16 INFO - 'SHELL': '/bin/bash', 21:33:16 INFO - 'SHLVL': '1', 21:33:16 INFO - 'TERM': 'linux', 21:33:16 INFO - 'TMOUT': '86400', 21:33:16 INFO - 'USER': 'cltbld', 21:33:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:16 INFO - '_': '/tools/buildbot/bin/python'} 21:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:33:16 INFO - Running setup.py (path:/tmp/pip-AUKcEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:33:16 INFO - Running setup.py (path:/tmp/pip-bY6dl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:33:16 INFO - Running setup.py (path:/tmp/pip-s9Zqp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:33:16 INFO - Running setup.py (path:/tmp/pip-57RlZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:33:16 INFO - Running setup.py (path:/tmp/pip-6TL7mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:33:16 INFO - Running setup.py (path:/tmp/pip-GXcBNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:33:16 INFO - Running setup.py (path:/tmp/pip-nnKrkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:33:16 INFO - Running setup.py (path:/tmp/pip-70dSX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:33:16 INFO - Running setup.py (path:/tmp/pip-sb4_3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:33:17 INFO - Running setup.py (path:/tmp/pip-XN8Nz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:33:17 INFO - Running setup.py (path:/tmp/pip-z_caQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:33:17 INFO - Running setup.py (path:/tmp/pip-inOXAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:33:17 INFO - Running setup.py (path:/tmp/pip-9t67hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:33:17 INFO - Running setup.py (path:/tmp/pip-AVloTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:17 INFO - Running setup.py (path:/tmp/pip-JlH8sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:33:17 INFO - Running setup.py (path:/tmp/pip-fZjZd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:33:17 INFO - Running setup.py (path:/tmp/pip-Gb7CnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:33:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:33:17 INFO - Running setup.py install for manifestparser 21:33:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:33:17 INFO - Running setup.py install for mozcrash 21:33:17 INFO - Running setup.py install for mozdebug 21:33:17 INFO - Running setup.py install for mozdevice 21:33:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Running setup.py install for mozfile 21:33:18 INFO - Running setup.py install for mozhttpd 21:33:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Running setup.py install for mozinfo 21:33:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Running setup.py install for mozInstall 21:33:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Running setup.py install for mozleak 21:33:18 INFO - Running setup.py install for mozlog 21:33:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Running setup.py install for moznetwork 21:33:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Running setup.py install for mozprocess 21:33:18 INFO - Running setup.py install for mozprofile 21:33:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:33:18 INFO - Running setup.py install for mozrunner 21:33:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:33:19 INFO - Running setup.py install for mozscreenshot 21:33:19 INFO - Running setup.py install for moztest 21:33:19 INFO - Running setup.py install for mozversion 21:33:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:33:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:33:19 INFO - Cleaning up... 21:33:19 INFO - Return code: 0 21:33:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:19 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 0x7f8f1446df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, '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': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:33:19 INFO - Using env: {'DISPLAY': ':0', 21:33:19 INFO - 'HOME': '/home/cltbld', 21:33:19 INFO - 'LANG': 'en_US.UTF-8', 21:33:19 INFO - 'LANGUAGE': 'en_US:en', 21:33:19 INFO - 'LOGNAME': 'cltbld', 21:33:19 INFO - 'MAIL': '/var/mail/cltbld', 21:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:19 INFO - 'MOZ_NO_REMOTE': '1', 21:33:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:19 INFO - 'NO_EM_RESTART': '1', 21:33:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:19 INFO - 'PWD': '/builds/slave/test', 21:33:19 INFO - 'SHELL': '/bin/bash', 21:33:19 INFO - 'SHLVL': '1', 21:33:19 INFO - 'TERM': 'linux', 21:33:19 INFO - 'TMOUT': '86400', 21:33:19 INFO - 'USER': 'cltbld', 21:33:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:19 INFO - '_': '/tools/buildbot/bin/python'} 21:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:33:19 INFO - Running setup.py (path:/tmp/pip-1OarJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:33:19 INFO - Running setup.py (path:/tmp/pip-buOKk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:33:19 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)) 21:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:33:19 INFO - Running setup.py (path:/tmp/pip-yOSsdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:33:19 INFO - Running setup.py (path:/tmp/pip-eP_Uhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:33:19 INFO - Running setup.py (path:/tmp/pip-SRwFLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:33:20 INFO - Running setup.py (path:/tmp/pip-Bb8UuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:33:20 INFO - Running setup.py (path:/tmp/pip-ErrpB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:33:20 INFO - Running setup.py (path:/tmp/pip-8YjOtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:33:20 INFO - Running setup.py (path:/tmp/pip-fA9OSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:33:20 INFO - Running setup.py (path:/tmp/pip-C5dQDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:33:20 INFO - Running setup.py (path:/tmp/pip-CDjF3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:33:20 INFO - Running setup.py (path:/tmp/pip-CRQl_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:33:20 INFO - Running setup.py (path:/tmp/pip-CoGNIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:33:20 INFO - Running setup.py (path:/tmp/pip-LU5zK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:33:20 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)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:20 INFO - Running setup.py (path:/tmp/pip-imNBn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:33:20 INFO - Running setup.py (path:/tmp/pip-pDJ79T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:33:20 INFO - Running setup.py (path:/tmp/pip-m4hvZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:33:20 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)) 21:33:20 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)) 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:33:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:22 INFO - Downloading blessings-1.6.tar.gz 21:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:33:22 INFO - Installing collected packages: blessings 21:33:22 INFO - Running setup.py install for blessings 21:33:23 INFO - Successfully installed blessings 21:33:23 INFO - Cleaning up... 21:33:23 INFO - Return code: 0 21:33:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:33:23 INFO - Reading from file tmpfile_stdout 21:33:23 INFO - Current package versions: 21:33:23 INFO - argparse == 1.2.1 21:33:23 INFO - blessings == 1.6 21:33:23 INFO - blobuploader == 1.2.4 21:33:23 INFO - docopt == 0.6.1 21:33:23 INFO - functools32 == 3.2.3-2 21:33:23 INFO - jsonschema == 2.5.1 21:33:23 INFO - manifestparser == 1.1 21:33:23 INFO - mozInstall == 1.12 21:33:23 INFO - mozcrash == 1.0 21:33:23 INFO - mozdebug == 0.1 21:33:23 INFO - mozdevice == 0.48 21:33:23 INFO - mozfile == 1.2 21:33:23 INFO - mozhttpd == 0.7 21:33:23 INFO - mozinfo == 0.9 21:33:23 INFO - mozleak == 0.1 21:33:23 INFO - mozlog == 3.4 21:33:23 INFO - moznetwork == 0.27 21:33:23 INFO - mozprocess == 0.23 21:33:23 INFO - mozprofile == 0.28 21:33:23 INFO - mozrunner == 6.13 21:33:23 INFO - mozscreenshot == 0.1 21:33:23 INFO - mozsystemmonitor == 0.3 21:33:23 INFO - moztest == 0.7 21:33:23 INFO - mozversion == 1.4 21:33:23 INFO - psutil == 3.1.1 21:33:23 INFO - requests == 1.2.3 21:33:23 INFO - wsgiref == 0.1.2 21:33:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:23 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 0x7f8f1446df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, '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': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:33:23 INFO - Using env: {'DISPLAY': ':0', 21:33:23 INFO - 'HOME': '/home/cltbld', 21:33:23 INFO - 'LANG': 'en_US.UTF-8', 21:33:23 INFO - 'LANGUAGE': 'en_US:en', 21:33:23 INFO - 'LOGNAME': 'cltbld', 21:33:23 INFO - 'MAIL': '/var/mail/cltbld', 21:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:23 INFO - 'MOZ_NO_REMOTE': '1', 21:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:23 INFO - 'NO_EM_RESTART': '1', 21:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:23 INFO - 'PWD': '/builds/slave/test', 21:33:23 INFO - 'SHELL': '/bin/bash', 21:33:23 INFO - 'SHLVL': '1', 21:33:23 INFO - 'TERM': 'linux', 21:33:23 INFO - 'TMOUT': '86400', 21:33:23 INFO - 'USER': 'cltbld', 21:33:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:23 INFO - '_': '/tools/buildbot/bin/python'} 21:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:33:23 INFO - Cleaning up... 21:33:23 INFO - Return code: 0 21:33:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:23 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 0x7f8f1446df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, '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': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:33:23 INFO - Using env: {'DISPLAY': ':0', 21:33:23 INFO - 'HOME': '/home/cltbld', 21:33:23 INFO - 'LANG': 'en_US.UTF-8', 21:33:23 INFO - 'LANGUAGE': 'en_US:en', 21:33:23 INFO - 'LOGNAME': 'cltbld', 21:33:23 INFO - 'MAIL': '/var/mail/cltbld', 21:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:23 INFO - 'MOZ_NO_REMOTE': '1', 21:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:23 INFO - 'NO_EM_RESTART': '1', 21:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:23 INFO - 'PWD': '/builds/slave/test', 21:33:23 INFO - 'SHELL': '/bin/bash', 21:33:23 INFO - 'SHLVL': '1', 21:33:23 INFO - 'TERM': 'linux', 21:33:23 INFO - 'TMOUT': '86400', 21:33:23 INFO - 'USER': 'cltbld', 21:33:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:23 INFO - '_': '/tools/buildbot/bin/python'} 21:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:33:23 INFO - Cleaning up... 21:33:23 INFO - Return code: 0 21:33:23 INFO - Running post-action listener: _resource_record_post_action 21:33:23 INFO - Running post-action listener: _start_resource_monitoring 21:33:23 INFO - Starting resource monitoring. 21:33:23 INFO - [mozharness: 2016-12-27 05:33:23.853306Z] Finished create-virtualenv step (success) 21:33:23 INFO - [mozharness: 2016-12-27 05:33:23.853819Z] Running install step. 21:33:23 INFO - Running pre-action listener: _resource_record_pre_action 21:33:23 INFO - Running main action method: install 21:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:33:24 INFO - Reading from file tmpfile_stdout 21:33:24 INFO - Detecting whether we're running mozinstall >=1.0... 21:33:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:33:24 INFO - Reading from file tmpfile_stdout 21:33:24 INFO - Output received: 21:33:24 INFO - Usage: mozinstall [options] installer 21:33:24 INFO - Options: 21:33:24 INFO - -h, --help show this help message and exit 21:33:24 INFO - -d DEST, --destination=DEST 21:33:24 INFO - Directory to install application into. [default: 21:33:24 INFO - "/builds/slave/test"] 21:33:24 INFO - --app=APP Application being installed. [default: firefox] 21:33:24 INFO - mkdir: /builds/slave/test/build/application 21:33:24 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'] 21:33:24 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 21:33:40 INFO - Reading from file tmpfile_stdout 21:33:40 INFO - Output received: 21:33:40 INFO - /builds/slave/test/build/application/firefox/firefox 21:33:40 INFO - Running post-action listener: _resource_record_post_action 21:33:40 INFO - [mozharness: 2016-12-27 05:33:40.082869Z] Finished install step (success) 21:33:40 INFO - [mozharness: 2016-12-27 05:33:40.083112Z] Running run-tests step. 21:33:40 INFO - Running pre-action listener: _resource_record_pre_action 21:33:40 INFO - Running main action method: run_tests 21:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:33:40 INFO - Python 2.7.3 21:33:40 INFO - Return code: 0 21:33:40 INFO - grabbing minidump binary from tooltool 21:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:40 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 0x25f7f60>, '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 0x25f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:33:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:33:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:33:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:33:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:33:40 INFO - Return code: 0 21:33:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:33:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:33:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:33:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:33:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:33:40 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/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:33:40 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/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:33:40 INFO - Using env: {'DISPLAY': ':0', 21:33:40 INFO - 'HOME': '/home/cltbld', 21:33:40 INFO - 'LANG': 'en_US.UTF-8', 21:33:40 INFO - 'LANGUAGE': 'en_US:en', 21:33:40 INFO - 'LOGNAME': 'cltbld', 21:33:40 INFO - 'MAIL': '/var/mail/cltbld', 21:33:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:33:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:40 INFO - 'MOZ_NO_REMOTE': '1', 21:33:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:33:40 INFO - 'NO_EM_RESTART': '1', 21:33:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:40 INFO - 'PWD': '/builds/slave/test', 21:33:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:33:40 INFO - 'SHELL': '/bin/bash', 21:33:40 INFO - 'SHLVL': '1', 21:33:40 INFO - 'TERM': 'linux', 21:33:40 INFO - 'TMOUT': '86400', 21:33:40 INFO - 'USER': 'cltbld', 21:33:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657', 21:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:40 INFO - '_': '/tools/buildbot/bin/python'} 21:33:40 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/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:33:40 INFO - mozversion application_buildid: 20161226195737 21:33:40 INFO - mozversion application_changeset: 5434909ba45c6df65a4e769ba80fe67ead95b785 21:33:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:33:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:33:40 INFO - mozversion application_name: Firefox 21:33:40 INFO - mozversion application_remotingname: firefox-dev 21:33:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:33:40 INFO - mozversion application_vendor: Mozilla 21:33:40 INFO - mozversion application_version: 52.0a2 21:33:40 INFO - mozversion platform_buildid: 20161226195737 21:33:40 INFO - mozversion platform_changeset: 5434909ba45c6df65a4e769ba80fe67ead95b785 21:33:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:33:40 INFO - mozversion platform_version: 52.0a2 21:33:40 INFO - using testdate: 1482816820 21:33:40 INFO - actual date: 1482816820 21:33:40 INFO - starting webserver on 'localhost:39986' 21:33:40 INFO - SUITE-START | Running 2 tests 21:33:40 INFO - TEST-START | dromaeo_css 21:33:40 INFO - operating with platform_type : linux_ 21:33:40 INFO - Initialising browser for dromaeo_css test... 21:33:40 INFO - TEST-INFO | started process 32230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF8fi42/profile http://localhost:39986/getInfo.html) 21:33:44 INFO - PROCESS | 32230 | __metrics Screen width/height:1600/1200 21:33:44 INFO - PROCESS | 32230 | colorDepth:24 21:33:44 INFO - PROCESS | 32230 | Browser inner width/height: 1024/697 21:33:44 INFO - PROCESS | 32230 | __metrics 21:33:44 INFO - PROCESS | 32230 | 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" 21:33:44 INFO - PROCESS | 32230 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:33:45 INFO - PROCESS | 32230 | console.error: PushService: 21:33:45 INFO - PROCESS | 32230 | stateChangeProcessEnqueue: Error transitioning state 21:33:45 INFO - PROCESS | 32230 | UnknownError 21:33:45 INFO - TEST-INFO | 32230: exit 0 21:33:45 INFO - Browser initialized. 21:33:45 INFO - Running cycle 1/1 for dromaeo_css test... 21:33:45 INFO - TEST-INFO | started process 32323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF8fi42/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:33:57 INFO - PROCESS | 32323 | RSS: Main: 144887808 21:33:57 INFO - PROCESS | 32323 | 21:34:49 INFO - PROCESS | 32323 | 1482816889068 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:36:59 INFO - PROCESS | 32323 | Cycle 1(1): loaded http://localhost:39986/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39986/tests/dromaeo/cssquery-ext.html) 21:37:00 INFO - PROCESS | 32323 | RSS: Main: 241811456 21:37:00 INFO - PROCESS | 32323 | 21:40:02 INFO - PROCESS | 32323 | Cycle 1(1): loaded http://localhost:39986/tests/dromaeo/cssquery-ext.html (next: http://localhost:39986/tests/dromaeo/cssquery-jquery.html) 21:40:03 INFO - PROCESS | 32323 | RSS: Main: 231882752 21:40:03 INFO - PROCESS | 32323 | 21:43:05 INFO - PROCESS | 32323 | Cycle 1(1): loaded http://localhost:39986/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39986/tests/dromaeo/cssquery-mootools.html) 21:43:05 INFO - PROCESS | 32323 | RSS: Main: 174665728 21:43:05 INFO - PROCESS | 32323 | 21:46:07 INFO - PROCESS | 32323 | Cycle 1(1): loaded http://localhost:39986/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39986/tests/dromaeo/cssquery-prototype.html) 21:46:08 INFO - PROCESS | 32323 | RSS: Main: 201424896 21:46:08 INFO - PROCESS | 32323 | 21:49:10 INFO - PROCESS | 32323 | Cycle 1(1): loaded http://localhost:39986/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39986/tests/dromaeo/cssquery-yui.html) 21:49:11 INFO - PROCESS | 32323 | RSS: Main: 178622464 21:49:11 INFO - PROCESS | 32323 | 21:52:13 INFO - PROCESS | 32323 | Cycle 1(1): loaded http://localhost:39986/tests/dromaeo/cssquery-yui.html (next: http://localhost:39986/tests/dromaeo/cssquery-dojo.html) 21:52:14 INFO - PROCESS | 32323 | RSS: Main: 247644160 21:52:14 INFO - PROCESS | 32323 | 21:52:14 INFO - PROCESS | 32323 | __start_tp_report 21:52:14 INFO - PROCESS | 32323 | _x_x_mozilla_page_load 21:52:14 INFO - PROCESS | 32323 | _x_x_mozilla_page_load_details 21:52:14 INFO - PROCESS | 32323 | |i|pagename|runs| 21:52:14 INFO - PROCESS | 32323 | |0;dojo.html;3168.984155079225;3195.15328437964;3201.599800024997;3226.53215283784;3245.853936572854;5464.836054918349;5500.064988951878;5534.667919924802;5543.279373681416;5568.832935011946;5540.889182216353;5608.495235428811;5611.579131565139;5623.550115990721;5642.069058605325;5060.316857224283;5092.185250359943;5121.871953201181;5170.922436163461;5189.506996835295;4890.608751299906;5132.435432102485;5189.42916279209;5190.844274671766;5201.817936372227;4906.264060390934;4943.950560494403;4964.280179373988;4973.925391119136;5016.372953380827;4996.900061998758;5005.54950054495;5067.366579177603;5070.518300761421;5094.847154585368;4743.430788305391;4935.111679897617;4971.975140124312;4988.700677959334;5032.672876263068;5218.982298451803;5381.461853814626;5408.486193811582;5410.83767486976;5476.780928762844;5853.560982926298;5881.2354393928945;5970.014947533695;5979.402059793986;5987.072003839412;5775.653460792366;5994.190784244115;6010.038393856962;6012.518998480155;6022.457978781887;5446.183072539111;5483.7806487740445;5552.11166213408;5569.331680198321;5579.721013949286;6105.877882442415;6110.511159107261;6115.6330620162935;6118.785842495491;6119.143319935212;5660.830175094754;5847.152162936435;5851.765929362863;5856.677882716492;5858.794942177088;5708.543316534668;5754.964106460793;5760.711964401847;5769.711514424262;5806.332271788714;5771.624844385102;5774.393688662714;5775.884482310415;5777.0467872801355;5810.94189058104;5724.77100915967;5757.740901659436;5767.826965191051;5796.971015144897;5808.30300363959;4461.57615026572;4502.662300327489;4506.346579745984;4549.294859296814;4551.658625603093;4066.5692498740636;4086.591340865949;4093.2222877653744;4118.032262418329;4121;5620.494155526022;5628.324601047901;5629.634073785191;5635.124678631172;5662.150677398423;5707.229524014205;5758.337791153987;5812.186293918855;5895.14520394549;5927.644341339534;5631.099024156198;5651.4348565143155;5655.236543066633;5658.066419040812;5671.886562268732;5154.3814742230425;5164;5174.456682048331;5185.948140518622;5204.479552044765;5894.351621321565;6012.248468941382;6063;6179.81460556184;6198.969005154945;5839.562032847469;5920.911186332295;5931.792387266425;5942.31663358702;5965.612235204698;6164.321924588202;6171.537134714825;6174.289956655042;6175.783847565313;6182.103594978793;5629.3244810621345;5637.689927054052;5822.330432000204;5823.301203855564;5829.213056237523;5870.7945221917025;5931.466168044896;5939.91090133657;6002.519798416029;6032.215811944595;5801.680907549957;5841.591088623755;5845.1232315153065;5850.268716410449;5857.619254748428;5881.823545293648;5888.735006924613;5895;5903.439173278532;5904.380040095728;5532;5607.887842243051;5619.438056194348;5640.041192997118;5654.40628733977;5680.261565996394;5712.828615141552;5713.514351280188;5718.79984200551;5748.597598168088;5541.861453463695;5578.2748242728185;5580.497755202051;5605.49550540437;5608.242887210337 21:52:14 INFO - PROCESS | 32323 | |1;ext.html;578.178985840107;598.3657323237366;603.2278683285394;610.0239616613417;620.1906512001838;33879;44990.550094499085;45648.31527527081;45779;45782.31326530105;46572.76713616436;46945.76527117368;46986.530134698645;47071.29393059098;47078.52921470784;8173.468724532886;8427.789305267355;8776.166264204907;8903.24322432594;8926.062763409846;10401.37591744494;10662.147028237761;10667;11000;11014.889851101467;10877.83683244752;10945.890541094606;10959.287646303004;10963.068139208177;10969;10618.469076546218;10632.946835265813;10686.625968091157;10706.732331691692;10707.83938240923;10538.841917371246;10603.151747860153;10605.84091238632;10616.309939853885;10623.893761062367;43476.78261608672;43769.12461750779;43817.78091109556;43828.78085609584;43829.34255986163;3881.5536213335545;3994.7003974701724;4131.5042194936495;4199.076203235283;4390.363397307405;32230.194245143826;32349.676503234903;32498;32635.6736432635;32824.6717532824;4095.24238015968;4125.133721918401;4149.107941792529;4183.958160418418;4212.452381190456;348848;350672;351078;351341;351678;61314;61647.691761540904;61651.6917415419;61728.69135654293;61737.69131154315;39192.6080739189;39970.40044399336;40179.196416071514;42215;42245.577544224776;18936.810631893506;19154.563407744474;19160.808391915903;19165.32921347774;19187.90406047961;12308.938455307845;12672.049596280316;13713.108647937852;14038.578842634737;14298;20241.79758202399;20368.981550922395;20413.591728165353;20581.07385167671;20655.380338589865;7102.467314951399;7334.119905611361;7384.264697796014;7385.519941203912;7469.365103966224;1043.5512729526376;1051.9947400263102;1088.0968795899385;1149.8677652069953;1209.6008317255285;33431.3313733724;33657.49513757296;33873.491897621556;34035.10701590392;34184.65815341865;1137.4597066393396;1156.4795841871191;1181.9290842549474;1238.349866320171;1240.8262843201958;16647.91676041612;17763.911180444014;17927.282908683508;17931.282748690166;17933.103344832707;521665;526412;527400;527513;527892;40212.39681404781;40784.79607602002;40880;40974.38538421926;41028.38457423141;1287.7617640736494;1312.2848047813964;1385.3073463268165;1388.7014291927082;1420.7655736803313;30224.244393890327;34044.148896277795;34823.303533929684;34950.47574286337;35007;50808.491915080376;51340.74329628328;51394.48605513897;51481;51500.742496287276;405771;407272;408728;408905;409844;29660.851695741385;29965.400691986473;30120.698793012667;31542;31628;48169.759151204016;48452.7577362125;48488;49637.25544116913;49963.75018124886;40209.597904020586;40792;41608.791956041234;41819.581804181566;42006.36990445207;41256.174876502904;41364.586354137275;41694.37458438187;42833;43114.78442607767;42009.369859452745;43234.35148472712;43284.78357608192;44022.77988610036;44037.33943990779;34716.47925281072;37123;37374.252514950094;37375.252494950495;38161.23677526379;29345.70654293515;29363.265918352212;29392.26519336948;29543.26141846471;29684.703152968195 21:52:14 INFO - PROCESS | 32323 | |2;jquery.html;386.953565572131;396.40737098038437;421.1429740478127;421.59526854219945;423.2973264381128;15405.229738513071;19446.222151113958;19613.705794413076;19631.31290404836;19659.11533980971;12431.502739890417;12820.230786152813;12942.352882355892;13088;13141.737165256713;5224.451432599589;5437.673739575638;5443.156310771837;5443.537299329561;5444.40111587725;3982.3429134192825;4104.671626269891;5315.096433606277;5767.452092051249;5987.700614969256;6059.242594675666;6069.21100256966;6074;6077.361877002917;6078.422549857756;5865.58940874139;6031.819045428622;6054.969725151346;6058.424449677252;6062.363451837582;5795.507381872546;5894.056950887837;5894.764209431618;5897.587168898179;6012.158297838306;23304.76695233043;23491.295261142193;23521;23548.411289717722;23608.64587031196;2208.326460429568;2535.2774459279017;2954.630671166104;3042.8326442045677;3138.5606015157896;10012.94993525035;10624.362538247653;10917.39954302513;11066.059384952288;11120.499577519031;1949.76602807664;2003.9699404508945;2009.899505024743;2010.8491863110326;2028.188724510193;82906.58546707289;86460;86571.56714216451;86610.5669471655;87703.56148219218;11252.831207531894;11571.6528504145;11587.942060289814;11915.165938384403;12017.759644807229;17136.48590542286;17193.57016074608;17193.57016074608;17197.484075477754;17205.56986075358;8428.536430496259;8539.103394143649;8545.529995850287;8764.03595604483;8998.55007249635;8322.875156872651;8365.414420990472;8442.831143377098;8573.914260857437;8601.483910965362;4128.772917489567;4958.404991401055;4983.277424773388;5156.226566015128;5285.735713214401;1853.4717605482372;1914.4448110048208;2044.6078088636332;2070.3892351756267;2128.723265975413;958.5782255807422;973.6300205921705;1038.9532471038822;1042.7288904884786;1054.773223756896;19823.60352792936;20114.69827952582;20120.89939550293;20133.19467221324;20285.087171077335;981.3768257156614;1023.1763430438419;1031.6750223679517;1055.456439933435;1077.439731339699;10404.219683523766;11394.1454390921;11477.54089836414;11477.598284060017;11605.419729013516;464196;465374;469385;475351;484513;89767.55116224378;91078.54460727653;91561;93258;94464.52767736117;972.1493693018608;991.8115558043949;999.715081201854;1009.7576581620358;1026.9435181065114;17619.55951101233;17808.821911780717;18152.45542633723;18213.089345532404;18332.17505212242;42028.57971420247;42196.789016054725;42863;43317;43338.56661433345;58149.418505816095;58967.70516147392;59423.70288148532;59472;59494.70252648709;8773.649054037767;8872.201501864864;8899.73300800977;8917.197452229331;9039.276857851488;11290.096792256436;11619.128565357463;11836.230645008047;11994.76010479768;12028.458719357825;10005.54975026111;10048.799024019625;10212.693619191436;10246.333988290737;10735.409552474377;10062.597496100367;10333.121684656888;10581.312214706328;10583.417912014913;10774.569017239222;10073.244506662177;10165.542550585093;10229.386236825814;10547.525361358605;10689.30519516229;8567.700130495403;8603.483790972561;8718.694845680624;8845.734627961172;8945.515839571508;9387.765305867408;10733.195010374096;10770.784584308114;10781.02970732638;10952.069074128789 21:52:14 INFO - PROCESS | 32323 | |3;mootools.html;1500.3773434024881;1531.4716422834122;1701.7022021146304;1785.134209908195;1839.2642942822877;8422.536760478171;9046.050164732707;9046.371653102431;9058.094190580947;9072.455652660828;7846.05847298325;8020.799480013003;8045.637946292416;8226.218509241628;8847.336449766277;2180.095260466904;2399.3641684953413;2459.0409740201335;2469.592517234654;2490.5641512735288;2435.7807797298237;2486.5648511510503;2499.6125600531946;2500.6749122614033;2534.1003943600035;2414;2421.794147497465;2439.8048156147556;2440.694913135858;2446.4006318452;2382.523495300938;2395.604725220328;2399.3881560202126;2400.1479474786547;2404.723456802473;2407.8916448759846;2434.294054724128;2447.1068060157913;2456.9385765355833;2461.5569197544437;8815.647374105029;8994.145556172152;9002.189802917768;9010.504422256774;9041.68354107603;5380;5539.639923404966;5541.390447050821;5542.722863856831;5549.38956714761;3295.307985323085;3450.8447119879665;3514.6309637488207;3591.6408359164134;3615.349237137314;1052.3422860712055;1076.8007918535018;1099.4173088263233;1100.1254003067581;1104.928179668327;11795.351255680935;12124.575639852563;12152.635420937298;12487.562935297312;12531.436085376088;4767.118083154627;4817;4861.854144375674;4870.196417591129;4985.850424487271;9844.261680373857;9850.556724947395;9867.161291290176;9869.06243906842;9883.06110919476;5393.217983392465;5408.0535906216255;5423.484768946943;5430.049741295336;5446.7276636168035;4525.479569849444;5012.097822391932;5091.439941606421;5097.923531147036;5174.560162386164;3733.4773131761576;3924.3917192834583;4035.6569691576547;4046.3814474210553;4103.261412945699;1245.4022069406735;1245.4893493667553;1265.5001274496522;1272.3765354975994;1286.5175559165314;736.8526294740966;876.1545108969748;889.6174644902754;917.0966597901062;924.8381533231658;5580.609357345028;5678.4605462480995;5682.857928551736;5693.68684722336;5902.321233058167;1003.789204267112;1014.3457469931852;1014.7412409835592;1047.5914393386586;1095.5508241621058;3832;3991.7006224533275;4037.1118353962083;4085;4113.321301985199;10779.838302425469;11258.605948791754;11332.376719280519;11345.31928084301;11347.716307092223;10819.459027048617;10926.399048052275;11023.228374013743;11038.503267352988;11116.277441966246;8228.80682301063;8279.710210142615;8420.62107205165;8445.704400346081;8485.490870547786;5759.596828221985;5869.413058694096;5916.112583112567;5966.463018328372;5991.64050156992;10117.140043096124;10162.288639795144;10232.02795734404;10292.536835842255;10309.123724483503;10052.44711540843;10227.28409011362;10459;10590.417527036087;10598;7624.8475030500185;7749.07011158642;7779.805504862424;7780.299773020455;7787.415943804351;7701.460897737329;7896.802579935547;8191.426600138171;8285;8411.789705257173;7327.780166595011;7668.386529077772;7688.038995125609;7817.570033648204;8034.95982520107;7223.530470519399;7269.854602907806;7409.481336306407;7466.887996680162;7469.850602988018;6715.899261511179;6740.258571557027;6783.253842077269;6795.694193761194;6806.591604503746;4953.405591329064;4970.27930950003;5005.824796132263;5044.596432285482;5092.41437234708;5017.197248440232;5064.316317297265;5176.197689358156;5248.107821670249;5293.655912365684 21:52:14 INFO - PROCESS | 32323 | |4;prototype.html;351.729168540224;352.0898477435828;361.4433771991134;366.25284419783645;366.5143684617882;5322.92015619766;5427.83716488506;5438.293021907151;5456.590755693324;5469.261649677293;5229.843104706865;5317.46825317469;5351.304330437048;5379.38137114232;5440.863978400542;4281.978590107045;4297.935530967038;4309.461317335333;4329.826806927719;4359.542248063955;4232.640225580829;4279.26127278542;4289;4339.370791235269;4339.587739164775;4238.474149306247;4240.194363071022;4250.681198910079;4254.149170165963;4289.82029941767;4256.765877876715;4257.169851878885;4274.871753847389;4286.5284818669925;4287.421198138242;3740.719446041531;3849.8460061597502;3851.480050193244;3854.113553882623;3857.112864041258;5235.58115350771;5235.921461178085;5252.240499432694;5256.395514515842;5313.601479889024;4931.7040977541465;4933.605311575066;4974.950250497485;4981.950180498185;4993.6005119590345;5499.50504454597;5648.858778530528;5668.858278543028;5676.347220069703;5705.258316418881;4210.936835947463;4219.346001369792;4230.238557059728;4236.07258697292;4249.107687385653;5867.413258674141;5872.647641141545;5888.411158884121;5896.734646940898;5941.405859414067;4152.148809494047;4292.849750258726;4297.39836422901;4334.978325108417;4336.70410488025;4382.167388196232;4383.189110014658;4399.316416985636;4400.647948164204;4409.4488188976375;4927.728974906343;4934.309196712463;4949.406071271398;4965.063625186181;4987.152184128707;5506.476884695948;5666.490015898589;5667.489925906606;5680.920625081221;5736.282964629421;1437.626217183519;1459.4527052355368;1467.8678918897351;1469.2139705257637;1470.9705805883823;998.2609698215836;1026.7484466305802;1037.1702637889657;1037.5434808684154;1046.7906418716286;5236.9738151309;5252.395974462909;5276.7335839398265;5279.41926388097;5290.365156181283;5558.610897237155;5593.944060559343;5603.3836278009385;5635;5639.082711877981;5085.084684756779;5285.973570132125;5307.230451584576;5309.787608495694;5311.840644780663;2963.599914011624;2968.9406211875644;2987.1181155871664;2987.1785259053936;2989.4768415527196;5836.212111364912;5842.357340692521;5863.824085277449;5895.115732640138;5903.527717782567;5602.982926146584;5877.617954833007;5878.353381128072;5886.262887757213;5906.822795316148;6003.6397816131175;6026.7890623828835;6034.48706859913;6036.215292012098;6044.9395506044375;5618.185363122406;5743.305724811107;5797.739101740516;5824.184614154106;5857.297124345106;5756.827295181151;5758.798442054508;5759.12043978011;5764.106563482667;5764.59647824665;5882.352941176553;5997.940020599913;6014.879702405839;6033.461467325804;6038.184845046038;4211.515675697334;4211.578842115764;4245.91508169841;4251.95748042528;4269.957300426956;5808.502343992124;5826.359100498857;5830.387809279964;5856;5901.439363260483;5551.361593416647;5668.5465162787705;5712.428757124254;5751.223584815996;5774.451427114417;5697.914531282117;5706.942930570641;5711.200431939449;5730.341010783646;5731.7420716067045;5651.180578815966;5663.348714897675;5678.8926159398525;5680.289963754531;5685.260916080883;5487.341519017584;5681.920435117315;5729.828105156852;5735.512481438957;5753.453421924911;5581.330240371181;5582.990123555435;5595.468430499096;5600.663960162403;5607.43925607436 21:52:14 INFO - PROCESS | 32323 | |5;yui.html;818.8536049530657;821.8726097454896;840.8360369727903;860.4880096342675;888.6045709659196;14098.365573549188;15063.548093557183;15081.321340539675;15092.622684432894;15097.169655668933;14665.266736663178;14817.77773333401;14844.851551484482;14854.851451485481;14888.925555372209;691.2948792231921;709.0286307758378;822.042320696391;853.0403296291672;853.0488505316589;850.4897061762923;852.7186028610574;855.9657613695445;856.9400141990063;858.0904241503995;900.5047224026791;900.6802585082299;900.918917297443;901.8782464367292;902.3457992955088;723.1936390924108;745.0128579632009;837.2590257621988;879.8812160358334;897.4615230861497;652.2108249018693;652.2499126005084;652.3965332067866;652.6508318049821;652.8824811533922;14627.976041677086;14646.340914658866;14673.339699713539;14675.63310917225;14692.926535367362;13132.409041593151;13222.801657975138;13553;14109.082909610945;14114.294285285694;12966.157199781985;13006.219626822422;13051.86948130516;13233.073684842066;13274.800877986838;4546.818127274905;4552.4764652065105;4575.611073058794;4642.466116396624;4689.765511724434;57128.71435642837;58582.121268180585;58834;65993;66479.99999999952;11398;11434.199606027498;11595.420228988685;11733;12110.455029523693;19709.40871773849;20384.59230815405;21186.788132118483;21367.78632213658;21452.356429307147;8135.227153420416;8489.363297752694;8551.144885511523;8576.099509551408;8582;4571.291449825282;4634.23535116702;4699.647526435463;4802.687825291345;4957.628177886673;3462.913427164341;3595.532580764484;3612.0428086557085;3617.8733744318824;3622.0763705255517;622.8972219583809;624.3537938233997;624.6127401011402;630.621627023782;638.3201889987241;709.8899670551073;753.9057617797775;774.376626815419;778.2178910195217;795.95224286543;8870.508555845183;9229.215516681023;9322.95338523303;9590.568424420917;9659.227261819038;740.9626522868028;757.5076200469739;764.9120351159577;775.6780935911534;775.968961241544;4597.885052873705;4711.552402521755;4717.8112875485285;4725.50382209863;4801.51984801517;89354;90470;90782;90935;93881;72534;76648;76748;79992.60003699944;80656.19343806604;67407.3259267401;68849.3115068853;71252.64373678202;72051.27948720551;74620;8886.595175593198;9245.167934885892;9265.490398027903;9272.350935434455;9276.72169834906;48273.517264828304;48731;49179.262311064645;50465.49534504755;51248.23127653163;61652.383476164665;65813.67093164695;66449.33550664625;68677;69306.30693692999;11497.770044599229;11520.654380368602;11523.654290371302;11666.824997624874;11787.057035437316;13533.052686311863;14209.786853197003;14446.638834029234;14584.708305834036;15091.471798487;12853.100282980102;13821.861781382058;14204.28978551089;14300.499482518062;15114.697706045597;13866.791998120238;14017.80848627878;14036.719265614427;14095.436182552994;14336;13826.792598110835;13882.305884705522;14022.719545609234;14130.15219086858;14249.28753562297;9794.706158815246;10404.947975260075;10548.525316360936;10605.363678179334;10718.35689858611;11414;11483.25358851672;11645.59240426581;11790.646280611596;11921.761564768483 21:52:14 INFO - PROCESS | 32323 | __end_tp_report 21:52:14 INFO - PROCESS | 32323 | __start_cc_report 21:52:14 INFO - PROCESS | 32323 | _x_x_mozilla_cycle_collect,955 21:52:14 INFO - PROCESS | 32323 | __end_cc_report 21:52:14 INFO - PROCESS | 32323 | __startTimestamp1482817934163__endTimestamp 21:52:14 INFO - PROCESS | 32323 | 21:52:14 INFO - PROCESS | 32323 | ------- Summary: start ------- 21:52:14 INFO - PROCESS | 32323 | Number of tests: 6 21:52:14 INFO - PROCESS | 32323 | 21:52:14 INFO - PROCESS | 32323 | [#0] dojo.html Cycles:165 Average:5484.15 Median:5654.41 stddev:612.91 (10.8%) stddev-sans-first:587.26 21:52:14 INFO - PROCESS | 32323 | Values: 3169.0 3195.2 3201.6 3226.5 3245.9 5464.8 5500.1 5534.7 5543.3 5568.8 5540.9 5608.5 5611.6 5623.6 5642.1 5060.3 5092.2 5121.9 5170.9 5189.5 4890.6 5132.4 5189.4 5190.8 5201.8 4906.3 4944.0 4964.3 4973.9 5016.4 4996.9 5005.5 5067.4 5070.5 5094.8 4743.4 4935.1 4972.0 4988.7 5032.7 5219.0 5381.5 5408.5 5410.8 5476.8 5853.6 5881.2 5970.0 5979.4 5987.1 5775.7 5994.2 6010.0 6012.5 6022.5 5446.2 5483.8 5552.1 5569.3 5579.7 6105.9 6110.5 6115.6 6118.8 6119.1 5660.8 5847.2 5851.8 5856.7 5858.8 5708.5 5755.0 5760.7 5769.7 5806.3 5771.6 5774.4 5775.9 5777.0 5810.9 5724.8 5757.7 5767.8 5797.0 5808.3 4461.6 4502.7 4506.3 4549.3 4551.7 4066.6 4086.6 4093.2 4118.0 4121.0 5620.5 5628.3 5629.6 5635.1 5662.2 5707.2 5758.3 5812.2 5895.1 5927.6 5631.1 5651.4 5655.2 5658.1 5671.9 5154.4 5164.0 5174.5 5185.9 5204.5 5894.4 6012.2 6063.0 6179.8 6199.0 5839.6 5920.9 5931.8 5942.3 5965.6 6164.3 6171.5 6174.3 6175.8 6182.1 5629.3 5637.7 5822.3 5823.3 5829.2 5870.8 5931.5 5939.9 6002.5 6032.2 5801.7 5841.6 5845.1 5850.3 5857.6 5881.8 5888.7 5895.0 5903.4 5904.4 5532.0 5607.9 5619.4 5640.0 5654.4 5680.3 5712.8 5713.5 5718.8 5748.6 5541.9 5578.3 5580.5 5605.5 5608.2 21:52:14 INFO - PROCESS | 32323 | 21:52:14 INFO - PROCESS | 32323 | [#1] ext.html Cycles:180 Average:59116.55 Median:21021.40 stddev:114889.48 (546.5%) stddev-sans-first:115127.70 21:52:14 INFO - PROCESS | 32323 | Values: 578.2 598.4 603.2 610.0 620.2 33879.0 44990.6 45648.3 45779.0 45782.3 46572.8 46945.8 46986.5 47071.3 47078.5 8173.5 8427.8 8776.2 8903.2 8926.1 10401.4 10662.1 10667.0 11000.0 11014.9 10877.8 10945.9 10959.3 10963.1 10969.0 10618.5 10632.9 10686.6 10706.7 10707.8 10538.8 10603.2 10605.8 10616.3 10623.9 43476.8 43769.1 43817.8 43828.8 43829.3 3881.6 3994.7 4131.5 4199.1 4390.4 32230.2 32349.7 32498.0 32635.7 32824.7 4095.2 4125.1 4149.1 4184.0 4212.5 348848.0 350672.0 351078.0 351341.0 351678.0 61314.0 61647.7 61651.7 61728.7 61737.7 39192.6 39970.4 40179.2 42215.0 42245.6 18936.8 19154.6 19160.8 19165.3 19187.9 12308.9 12672.0 13713.1 14038.6 14298.0 20241.8 20369.0 20413.6 20581.1 20655.4 7102.5 7334.1 7384.3 7385.5 7469.4 1043.6 1052.0 1088.1 1149.9 1209.6 33431.3 33657.5 33873.5 34035.1 34184.7 1137.5 1156.5 1181.9 1238.3 1240.8 16647.9 17763.9 17927.3 17931.3 17933.1 521665.0 526412.0 527400.0 527513.0 527892.0 40212.4 40784.8 40880.0 40974.4 41028.4 1287.8 1312.3 1385.3 1388.7 1420.8 30224.2 34044.1 34823.3 34950.5 35007.0 50808.5 51340.7 51394.5 51481.0 51500.7 405771.0 407272.0 408728.0 408905.0 409844.0 29660.9 29965.4 30120.7 31542.0 31628.0 48169.8 48452.8 48488.0 49637.3 49963.8 40209.6 40792.0 41608.8 41819.6 42006.4 41256.2 41364.6 41694.4 42833.0 43114.8 42009.4 43234.4 43284.8 44022.8 44037.3 34716.5 37123.0 37374.3 37375.3 38161.2 29345.7 29363.3 29392.3 29543.3 29684.7 21:52:14 INFO - PROCESS | 32323 | 21:52:14 INFO - PROCESS | 32323 | [#2] jquery.html Cycles:180 Average:28540.55 Median:2998.73 stddev:78043.09 (2602.5%) stddev-sans-first:78233.39 21:52:14 INFO - PROCESS | 32323 | Values: 387.0 396.4 421.1 421.6 423.3 15405.2 19446.2 19613.7 19631.3 19659.1 12431.5 12820.2 12942.4 13088.0 13141.7 5224.5 5437.7 5443.2 5443.5 5444.4 3982.3 4104.7 5315.1 5767.5 5987.7 6059.2 6069.2 6074.0 6077.4 6078.4 5865.6 6031.8 6055.0 6058.4 6062.4 5795.5 5894.1 5894.8 5897.6 6012.2 23304.8 23491.3 23521.0 23548.4 23608.6 2208.3 2535.3 2954.6 3042.8 3138.6 10012.9 10624.4 10917.4 11066.1 11120.5 1949.8 2004.0 2009.9 2010.8 2028.2 82906.6 86460.0 86571.6 86610.6 87703.6 11252.8 11571.7 11587.9 11915.2 12017.8 17136.5 17193.6 17193.6 17197.5 17205.6 8428.5 8539.1 8545.5 8764.0 8998.6 8322.9 8365.4 8442.8 8573.9 8601.5 4128.8 4958.4 4983.3 5156.2 5285.7 1853.5 1914.4 2044.6 2070.4 2128.7 958.6 973.6 1039.0 1042.7 1054.8 19823.6 20114.7 20120.9 20133.2 20285.1 981.4 1023.2 1031.7 1055.5 1077.4 10404.2 11394.1 11477.5 11477.6 11605.4 464196.0 465374.0 469385.0 475351.0 484513.0 89767.6 91078.5 91561.0 93258.0 94464.5 972.1 991.8 999.7 1009.8 1026.9 17619.6 17808.8 18152.5 18213.1 18332.2 42028.6 42196.8 42863.0 43317.0 43338.6 58149.4 58967.7 59423.7 59472.0 59494.7 8773.6 8872.2 8899.7 8917.2 9039.3 11290.1 11619.1 11836.2 11994.8 12028.5 10005.5 10048.8 10212.7 10246.3 10735.4 10062.6 10333.1 10581.3 10583.4 10774.6 10073.2 10165.5 10229.4 10547.5 10689.3 8567.7 8603.5 8718.7 8845.7 8945.5 9387.8 10733.2 10770.8 10781.0 10952.1 21:52:14 INFO - PROCESS | 32323 | 21:52:14 INFO - PROCESS | 32323 | [#3] mootools.html Cycles:180 Average:5809.93 Median:4961.84 stddev:3265.47 (65.8%) stddev-sans-first:3258.57 21:52:14 INFO - PROCESS | 32323 | Values: 1500.4 1531.5 1701.7 1785.1 1839.3 8422.5 9046.1 9046.4 9058.1 9072.5 7846.1 8020.8 8045.6 8226.2 8847.3 2180.1 2399.4 2459.0 2469.6 2490.6 2435.8 2486.6 2499.6 2500.7 2534.1 2414.0 2421.8 2439.8 2440.7 2446.4 2382.5 2395.6 2399.4 2400.1 2404.7 2407.9 2434.3 2447.1 2456.9 2461.6 8815.6 8994.1 9002.2 9010.5 9041.7 5380.0 5539.6 5541.4 5542.7 5549.4 3295.3 3450.8 3514.6 3591.6 3615.3 1052.3 1076.8 1099.4 1100.1 1104.9 11795.4 12124.6 12152.6 12487.6 12531.4 4767.1 4817.0 4861.9 4870.2 4985.9 9844.3 9850.6 9867.2 9869.1 9883.1 5393.2 5408.1 5423.5 5430.0 5446.7 4525.5 5012.1 5091.4 5097.9 5174.6 3733.5 3924.4 4035.7 4046.4 4103.3 1245.4 1245.5 1265.5 1272.4 1286.5 736.9 876.2 889.6 917.1 924.8 5580.6 5678.5 5682.9 5693.7 5902.3 1003.8 1014.3 1014.7 1047.6 1095.6 3832.0 3991.7 4037.1 4085.0 4113.3 10779.8 11258.6 11332.4 11345.3 11347.7 10819.5 10926.4 11023.2 11038.5 11116.3 8228.8 8279.7 8420.6 8445.7 8485.5 5759.6 5869.4 5916.1 5966.5 5991.6 10117.1 10162.3 10232.0 10292.5 10309.1 10052.4 10227.3 10459.0 10590.4 10598.0 7624.8 7749.1 7779.8 7780.3 7787.4 7701.5 7896.8 8191.4 8285.0 8411.8 7327.8 7668.4 7688.0 7817.6 8035.0 7223.5 7269.9 7409.5 7466.9 7469.9 6715.9 6740.3 6783.3 6795.7 6806.6 4953.4 4970.3 5005.8 5044.6 5092.4 5017.2 5064.3 5176.2 5248.1 5293.7 21:52:14 INFO - PROCESS | 32323 | 21:52:14 INFO - PROCESS | 32323 | [#4] prototype.html Cycles:180 Average:4795.77 Median:5320.19 stddev:1379.11 (25.9%) stddev-sans-first:1342.04 21:52:14 INFO - PROCESS | 32323 | Values: 351.7 352.1 361.4 366.3 366.5 5322.9 5427.8 5438.3 5456.6 5469.3 5229.8 5317.5 5351.3 5379.4 5440.9 4282.0 4297.9 4309.5 4329.8 4359.5 4232.6 4279.3 4289.0 4339.4 4339.6 4238.5 4240.2 4250.7 4254.1 4289.8 4256.8 4257.2 4274.9 4286.5 4287.4 3740.7 3849.8 3851.5 3854.1 3857.1 5235.6 5235.9 5252.2 5256.4 5313.6 4931.7 4933.6 4975.0 4982.0 4993.6 5499.5 5648.9 5668.9 5676.3 5705.3 4210.9 4219.3 4230.2 4236.1 4249.1 5867.4 5872.6 5888.4 5896.7 5941.4 4152.1 4292.8 4297.4 4335.0 4336.7 4382.2 4383.2 4399.3 4400.6 4409.4 4927.7 4934.3 4949.4 4965.1 4987.2 5506.5 5666.5 5667.5 5680.9 5736.3 1437.6 1459.5 1467.9 1469.2 1471.0 998.3 1026.7 1037.2 1037.5 1046.8 5237.0 5252.4 5276.7 5279.4 5290.4 5558.6 5593.9 5603.4 5635.0 5639.1 5085.1 5286.0 5307.2 5309.8 5311.8 2963.6 2968.9 2987.1 2987.2 2989.5 5836.2 5842.4 5863.8 5895.1 5903.5 5603.0 5877.6 5878.4 5886.3 5906.8 6003.6 6026.8 6034.5 6036.2 6044.9 5618.2 5743.3 5797.7 5824.2 5857.3 5756.8 5758.8 5759.1 5764.1 5764.6 5882.4 5997.9 6014.9 6033.5 6038.2 4211.5 4211.6 4245.9 4252.0 4270.0 5808.5 5826.4 5830.4 5856.0 5901.4 5551.4 5668.5 5712.4 5751.2 5774.5 5697.9 5706.9 5711.2 5730.3 5731.7 5651.2 5663.3 5678.9 5680.3 5685.3 5487.3 5681.9 5729.8 5735.5 5753.5 5581.3 5583.0 5595.5 5600.7 5607.4 21:52:14 INFO - PROCESS | 32323 | 21:52:14 INFO - PROCESS | 32323 | [#5] yui.html Cycles:180 Average:18388.57 Median:27068.45 stddev:24153.23 (89.2%) stddev-sans-first:24184.95 21:52:14 INFO - PROCESS | 32323 | Values: 818.9 821.9 840.8 860.5 888.6 14098.4 15063.5 15081.3 15092.6 15097.2 14665.3 14817.8 14844.9 14854.9 14888.9 691.3 709.0 822.0 853.0 853.0 850.5 852.7 856.0 856.9 858.1 900.5 900.7 900.9 901.9 902.3 723.2 745.0 837.3 879.9 897.5 652.2 652.2 652.4 652.7 652.9 14628.0 14646.3 14673.3 14675.6 14692.9 13132.4 13222.8 13553.0 14109.1 14114.3 12966.2 13006.2 13051.9 13233.1 13274.8 4546.8 4552.5 4575.6 4642.5 4689.8 57128.7 58582.1 58834.0 65993.0 66480.0 11398.0 11434.2 11595.4 11733.0 12110.5 19709.4 20384.6 21186.8 21367.8 21452.4 8135.2 8489.4 8551.1 8576.1 8582.0 4571.3 4634.2 4699.6 4802.7 4957.6 3462.9 3595.5 3612.0 3617.9 3622.1 622.9 624.4 624.6 630.6 638.3 709.9 753.9 774.4 778.2 796.0 8870.5 9229.2 9323.0 9590.6 9659.2 741.0 757.5 764.9 775.7 776.0 4597.9 4711.6 4717.8 4725.5 4801.5 89354.0 90470.0 90782.0 90935.0 93881.0 72534.0 76648.0 76748.0 79992.6 80656.2 67407.3 68849.3 71252.6 72051.3 74620.0 8886.6 9245.2 9265.5 9272.4 9276.7 48273.5 48731.0 49179.3 50465.5 51248.2 61652.4 65813.7 66449.3 68677.0 69306.3 11497.8 11520.7 11523.7 11666.8 11787.1 13533.1 14209.8 14446.6 14584.7 15091.5 12853.1 13821.9 14204.3 14300.5 15114.7 13866.8 14017.8 14036.7 14095.4 14336.0 13826.8 13882.3 14022.7 14130.2 14249.3 9794.7 10404.9 10548.5 10605.4 10718.4 11414.0 11483.3 11645.6 11790.6 11921.8 21:52:14 INFO - PROCESS | 32323 | -------- Summary: end -------- 21:52:14 INFO - PROCESS | 32323 | 21:52:14 INFO - TEST-INFO | 32323: exit 0 21:52:14 INFO - TEST-OK | dromaeo_css | took 1114553ms 21:52:14 INFO - TEST-START | kraken 21:52:14 INFO - operating with platform_type : linux_ 21:52:14 INFO - Initialising browser for kraken test... 21:52:14 INFO - TEST-INFO | started process 32649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLMWHgE/profile http://localhost:39986/getInfo.html) 21:52:18 INFO - PROCESS | 32649 | __metrics Screen width/height:1600/1200 21:52:18 INFO - PROCESS | 32649 | colorDepth:24 21:52:18 INFO - PROCESS | 32649 | Browser inner width/height: 1024/697 21:52:18 INFO - PROCESS | 32649 | __metrics 21:52:19 INFO - PROCESS | 32649 | 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" 21:52:19 INFO - PROCESS | 32649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:52:19 INFO - PROCESS | 32649 | console.error: PushService: 21:52:19 INFO - PROCESS | 32649 | stateChangeProcessEnqueue: Error transitioning state 21:52:19 INFO - PROCESS | 32649 | UnknownError 21:52:20 INFO - TEST-INFO | 32649: exit 0 21:52:20 INFO - Browser initialized. 21:52:20 INFO - Running cycle 1/1 for kraken test... 21:52:20 INFO - TEST-INFO | started process 32742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLMWHgE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:52:31 INFO - PROCESS | 32742 | RSS: Main: 144461824 21:52:31 INFO - PROCESS | 32742 | 21:52:34 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39986/tests/kraken/driver.html?testName=audio-beat-detection) 21:52:35 INFO - PROCESS | 32742 | RSS: Main: 185790464 21:52:35 INFO - PROCESS | 32742 | 21:52:37 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39986/tests/kraken/driver.html?testName=audio-dft) 21:52:38 INFO - PROCESS | 32742 | RSS: Main: 175484928 21:52:38 INFO - PROCESS | 32742 | 21:52:41 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39986/tests/kraken/driver.html?testName=audio-fft) 21:52:41 INFO - PROCESS | 32742 | RSS: Main: 266178560 21:52:41 INFO - PROCESS | 32742 | 21:52:43 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39986/tests/kraken/driver.html?testName=audio-oscillator) 21:52:44 INFO - PROCESS | 32742 | RSS: Main: 172945408 21:52:44 INFO - PROCESS | 32742 | 21:52:46 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39986/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:52:47 INFO - PROCESS | 32742 | RSS: Main: 175988736 21:52:47 INFO - PROCESS | 32742 | 21:52:50 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39986/tests/kraken/driver.html?testName=imaging-darkroom) 21:52:50 INFO - PROCESS | 32742 | RSS: Main: 214765568 21:52:50 INFO - PROCESS | 32742 | 21:52:54 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39986/tests/kraken/driver.html?testName=imaging-desaturate) 21:52:54 INFO - PROCESS | 32742 | RSS: Main: 213303296 21:52:54 INFO - PROCESS | 32742 | 21:52:57 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39986/tests/kraken/driver.html?testName=json-parse-financial) 21:52:57 INFO - PROCESS | 32742 | RSS: Main: 211640320 21:52:57 INFO - PROCESS | 32742 | 21:52:59 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39986/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:52:59 INFO - PROCESS | 32742 | RSS: Main: 174518272 21:52:59 INFO - PROCESS | 32742 | 21:53:01 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39986/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:53:02 INFO - PROCESS | 32742 | RSS: Main: 180551680 21:53:02 INFO - PROCESS | 32742 | 21:53:04 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39986/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:53:04 INFO - PROCESS | 32742 | RSS: Main: 189251584 21:53:04 INFO - PROCESS | 32742 | 21:53:07 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:53:08 INFO - PROCESS | 32742 | RSS: Main: 198934528 21:53:08 INFO - PROCESS | 32742 | 21:53:10 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:53:11 INFO - PROCESS | 32742 | RSS: Main: 194834432 21:53:11 INFO - PROCESS | 32742 | 21:53:12 INFO - PROCESS | 32742 | Cycle 1(1): loaded http://localhost:39986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39986/tests/kraken/driver.html?testName=ai-astar) 21:53:13 INFO - PROCESS | 32742 | RSS: Main: 246329344 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | __start_tp_report 21:53:13 INFO - PROCESS | 32742 | _x_x_mozilla_page_load 21:53:13 INFO - PROCESS | 32742 | _x_x_mozilla_page_load_details 21:53:13 INFO - PROCESS | 32742 | |i|pagename|runs| 21:53:13 INFO - PROCESS | 32742 | |0;ai-astar;102;110;110;109;111;110;111;111;110;110 21:53:13 INFO - PROCESS | 32742 | |1;audio-beat-detection;148;119;121;151;119;118;117;116;159;122 21:53:13 INFO - PROCESS | 32742 | |2;audio-dft;162;163;161;161;161;161;159;160;162;161 21:53:13 INFO - PROCESS | 32742 | |3;audio-fft;74;76;76;112;76;76;75;75;97;76 21:53:13 INFO - PROCESS | 32742 | |4;audio-oscillator;82;83;117;82;82;83;98;82;82;110 21:53:13 INFO - PROCESS | 32742 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;118;116;116 21:53:13 INFO - PROCESS | 32742 | |6;imaging-darkroom;146;145;146;146;146;146;146;145;146;147 21:53:13 INFO - PROCESS | 32742 | |7;imaging-desaturate;84;85;85;85;84;85;84;85;85;84 21:53:13 INFO - PROCESS | 32742 | |8;json-parse-financial;53;52;51;51;51;51;52;51;51;51 21:53:13 INFO - PROCESS | 32742 | |9;json-stringify-tinderbox;59;58;59;58;58;58;58;58;58;60 21:53:13 INFO - PROCESS | 32742 | |10;stanford-crypto-aes;74;74;75;74;74;73;74;78;78;79 21:53:13 INFO - PROCESS | 32742 | |11;stanford-crypto-ccm;122;128;122;125;122;132;123;117;156;142 21:53:13 INFO - PROCESS | 32742 | |12;stanford-crypto-pbkdf2;153;156;153;155;154;155;152;154;153;151 21:53:13 INFO - PROCESS | 32742 | |13;stanford-crypto-sha256-iterative;61;62;62;63;62;73;62;63;61;69 21:53:13 INFO - PROCESS | 32742 | __end_tp_report 21:53:13 INFO - PROCESS | 32742 | __start_cc_report 21:53:13 INFO - PROCESS | 32742 | _x_x_mozilla_cycle_collect,1620 21:53:13 INFO - PROCESS | 32742 | __end_cc_report 21:53:13 INFO - PROCESS | 32742 | __startTimestamp1482817993199__endTimestamp 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | ------- Summary: start ------- 21:53:13 INFO - PROCESS | 32742 | Number of tests: 14 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.67 (2.4%) stddev-sans-first:0.67 21:53:13 INFO - PROCESS | 32742 | Values: 102.0 110.0 110.0 109.0 111.0 110.0 111.0 111.0 110.0 110.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:121.50 stddev:16.64 (13.7%) stddev-sans-first:16.17 21:53:13 INFO - PROCESS | 32742 | Values: 148.0 119.0 121.0 151.0 119.0 118.0 117.0 116.0 159.0 122.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 21:53:13 INFO - PROCESS | 32742 | Values: 162.0 163.0 161.0 161.0 161.0 161.0 159.0 160.0 162.0 161.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:12.75 (16.8%) stddev-sans-first:13.24 21:53:13 INFO - PROCESS | 32742 | Values: 74.0 76.0 76.0 112.0 76.0 76.0 75.0 75.0 97.0 76.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.00 stddev:13.38 (16.3%) stddev-sans-first:13.87 21:53:13 INFO - PROCESS | 32742 | Values: 82.0 83.0 117.0 82.0 82.0 83.0 98.0 82.0 82.0 110.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 21:53:13 INFO - PROCESS | 32742 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 116.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 21:53:13 INFO - PROCESS | 32742 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 147.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 21:53:13 INFO - PROCESS | 32742 | Values: 84.0 85.0 85.0 85.0 84.0 85.0 84.0 85.0 85.0 84.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.44 21:53:13 INFO - PROCESS | 32742 | Values: 53.0 52.0 51.0 51.0 51.0 51.0 52.0 51.0 51.0 51.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 21:53:13 INFO - PROCESS | 32742 | Values: 59.0 58.0 59.0 58.0 58.0 58.0 58.0 58.0 58.0 60.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:74.50 stddev:2.16 (2.9%) stddev-sans-first:2.24 21:53:13 INFO - PROCESS | 32742 | Values: 74.0 74.0 75.0 74.0 74.0 73.0 74.0 78.0 78.0 79.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:126.50 stddev:11.79 (9.3%) stddev-sans-first:12.24 21:53:13 INFO - PROCESS | 32742 | Values: 122.0 128.0 122.0 125.0 122.0 132.0 123.0 117.0 156.0 142.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.00 stddev:1.51 (1.0%) stddev-sans-first:1.58 21:53:13 INFO - PROCESS | 32742 | Values: 153.0 156.0 153.0 155.0 154.0 155.0 152.0 154.0 153.0 151.0 21:53:13 INFO - PROCESS | 32742 | 21:53:13 INFO - PROCESS | 32742 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:62.50 stddev:3.97 (6.3%) stddev-sans-first:4.08 21:53:13 INFO - PROCESS | 32742 | Values: 61.0 62.0 62.0 63.0 62.0 73.0 62.0 63.0 61.0 69.0 21:53:13 INFO - PROCESS | 32742 | -------- Summary: end -------- 21:53:13 INFO - PROCESS | 32742 | 21:53:14 INFO - TEST-INFO | 32742: exit 0 21:53:14 INFO - TEST-OK | kraken | took 59313ms 21:53:14 INFO - SUITE-END | took 1173s 21:53:14 INFO - Completed test suite (00:19:33) 21:53:14 INFO - javascript benchmark 21:53:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3168.984155079225, 3195.15328437964, 3201.599800024997, 3226.53215283784, 3245.853936572854, 5464.836054918349, 5500.064988951878, 5534.667919924802, 5543.279373681416, 5568.832935011946, 5540.889182216353, 5608.495235428811, 5611.579131565139, 5623.550115990721, 5642.069058605325, 5060.316857224283, 5092.185250359943, 5121.871953201181, 5170.922436163461, 5189.506996835295, 4890.608751299906, 5132.435432102485, 5189.42916279209, 5190.844274671766, 5201.817936372227, 4906.264060390934, 4943.950560494403, 4964.280179373988, 4973.925391119136, 5016.372953380827, 4996.900061998758, 5005.54950054495, 5067.366579177603, 5070.518300761421, 5094.847154585368, 4743.430788305391, 4935.111679897617, 4971.975140124312, 4988.700677959334, 5032.672876263068, 5218.982298451803, 5381.461853814626, 5408.486193811582, 5410.83767486976, 5476.780928762844, 5853.560982926298, 5881.2354393928945, 5970.014947533695, 5979.402059793986, 5987.072003839412, 5775.653460792366, 5994.190784244115, 6010.038393856962, 6012.518998480155, 6022.457978781887, 5446.183072539111, 5483.7806487740445, 5552.11166213408, 5569.331680198321, 5579.721013949286, 6105.877882442415, 6110.511159107261, 6115.6330620162935, 6118.785842495491, 6119.143319935212, 5660.830175094754, 5847.152162936435, 5851.765929362863, 5856.677882716492, 5858.794942177088, 5708.543316534668, 5754.964106460793, 5760.711964401847, 5769.711514424262, 5806.332271788714, 5771.624844385102, 5774.393688662714, 5775.884482310415, 5777.0467872801355, 5810.94189058104, 5724.77100915967, 5757.740901659436, 5767.826965191051, 5796.971015144897, 5808.30300363959, 4461.57615026572, 4502.662300327489, 4506.346579745984, 4549.294859296814, 4551.658625603093, 4066.5692498740636, 4086.591340865949, 4093.2222877653744, 4118.032262418329, 4121.0, 5620.494155526022, 5628.324601047901, 5629.634073785191, 5635.124678631172, 5662.150677398423, 5707.229524014205, 5758.337791153987, 5812.186293918855, 5895.14520394549, 5927.644341339534, 5631.099024156198, 5651.4348565143155, 5655.236543066633, 5658.066419040812, 5671.886562268732, 5154.3814742230425, 5164.0, 5174.456682048331, 5185.948140518622, 5204.479552044765, 5894.351621321565, 6012.248468941382, 6063.0, 6179.81460556184, 6198.969005154945, 5839.562032847469, 5920.911186332295, 5931.792387266425, 5942.31663358702, 5965.612235204698, 6164.321924588202, 6171.537134714825, 6174.289956655042, 6175.783847565313, 6182.103594978793, 5629.3244810621345, 5637.689927054052, 5822.330432000204, 5823.301203855564, 5829.213056237523, 5870.7945221917025, 5931.466168044896, 5939.91090133657, 6002.519798416029, 6032.215811944595, 5801.680907549957, 5841.591088623755, 5845.1232315153065, 5850.268716410449, 5857.619254748428, 5881.823545293648, 5888.735006924613, 5895.0, 5903.439173278532, 5904.380040095728, 5532.0, 5607.887842243051, 5619.438056194348, 5640.041192997118, 5654.40628733977, 5680.261565996394, 5712.828615141552, 5713.514351280188, 5718.79984200551, 5748.597598168088, 5541.861453463695, 5578.2748242728185, 5580.497755202051, 5605.49550540437, 5608.242887210337], "value": 5443.530140183688, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.178985840107, 598.3657323237366, 603.2278683285394, 610.0239616613417, 620.1906512001838, 33879.0, 44990.550094499085, 45648.31527527081, 45779.0, 45782.31326530105, 46572.76713616436, 46945.76527117368, 46986.530134698645, 47071.29393059098, 47078.52921470784, 8173.468724532886, 8427.789305267355, 8776.166264204907, 8903.24322432594, 8926.062763409846, 10401.37591744494, 10662.147028237761, 10667.0, 11000.0, 11014.889851101467, 10877.83683244752, 10945.890541094606, 10959.287646303004, 10963.068139208177, 10969.0, 10618.469076546218, 10632.946835265813, 10686.625968091157, 10706.732331691692, 10707.83938240923, 10538.841917371246, 10603.151747860153, 10605.84091238632, 10616.309939853885, 10623.893761062367, 43476.78261608672, 43769.12461750779, 43817.78091109556, 43828.78085609584, 43829.34255986163, 3881.5536213335545, 3994.7003974701724, 4131.5042194936495, 4199.076203235283, 4390.363397307405, 32230.194245143826, 32349.676503234903, 32498.0, 32635.6736432635, 32824.6717532824, 4095.24238015968, 4125.133721918401, 4149.107941792529, 4183.958160418418, 4212.452381190456, 348848.0, 350672.0, 351078.0, 351341.0, 351678.0, 61314.0, 61647.691761540904, 61651.6917415419, 61728.69135654293, 61737.69131154315, 39192.6080739189, 39970.40044399336, 40179.196416071514, 42215.0, 42245.577544224776, 18936.810631893506, 19154.563407744474, 19160.808391915903, 19165.32921347774, 19187.90406047961, 12308.938455307845, 12672.049596280316, 13713.108647937852, 14038.578842634737, 14298.0, 20241.79758202399, 20368.981550922395, 20413.591728165353, 20581.07385167671, 20655.380338589865, 7102.467314951399, 7334.119905611361, 7384.264697796014, 7385.519941203912, 7469.365103966224, 1043.5512729526376, 1051.9947400263102, 1088.0968795899385, 1149.8677652069953, 1209.6008317255285, 33431.3313733724, 33657.49513757296, 33873.491897621556, 34035.10701590392, 34184.65815341865, 1137.4597066393396, 1156.4795841871191, 1181.9290842549474, 1238.349866320171, 1240.8262843201958, 16647.91676041612, 17763.911180444014, 17927.282908683508, 17931.282748690166, 17933.103344832707, 521665.0, 526412.0, 527400.0, 527513.0, 527892.0, 40212.39681404781, 40784.79607602002, 40880.0, 40974.38538421926, 41028.38457423141, 1287.7617640736494, 1312.2848047813964, 1385.3073463268165, 1388.7014291927082, 1420.7655736803313, 30224.244393890327, 34044.148896277795, 34823.303533929684, 34950.47574286337, 35007.0, 50808.491915080376, 51340.74329628328, 51394.48605513897, 51481.0, 51500.742496287276, 405771.0, 407272.0, 408728.0, 408905.0, 409844.0, 29660.851695741385, 29965.400691986473, 30120.698793012667, 31542.0, 31628.0, 48169.759151204016, 48452.7577362125, 48488.0, 49637.25544116913, 49963.75018124886, 40209.597904020586, 40792.0, 41608.791956041234, 41819.581804181566, 42006.36990445207, 41256.174876502904, 41364.586354137275, 41694.37458438187, 42833.0, 43114.78442607767, 42009.369859452745, 43234.35148472712, 43284.78357608192, 44022.77988610036, 44037.33943990779, 34716.47925281072, 37123.0, 37374.252514950094, 37375.252494950495, 38161.23677526379, 29345.70654293515, 29363.265918352212, 29392.26519336948, 29543.26141846471, 29684.703152968195], "value": 20686.42492093955, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.953565572131, 396.40737098038437, 421.1429740478127, 421.59526854219945, 423.2973264381128, 15405.229738513071, 19446.222151113958, 19613.705794413076, 19631.31290404836, 19659.11533980971, 12431.502739890417, 12820.230786152813, 12942.352882355892, 13088.0, 13141.737165256713, 5224.451432599589, 5437.673739575638, 5443.156310771837, 5443.537299329561, 5444.40111587725, 3982.3429134192825, 4104.671626269891, 5315.096433606277, 5767.452092051249, 5987.700614969256, 6059.242594675666, 6069.21100256966, 6074.0, 6077.361877002917, 6078.422549857756, 5865.58940874139, 6031.819045428622, 6054.969725151346, 6058.424449677252, 6062.363451837582, 5795.507381872546, 5894.056950887837, 5894.764209431618, 5897.587168898179, 6012.158297838306, 23304.76695233043, 23491.295261142193, 23521.0, 23548.411289717722, 23608.64587031196, 2208.326460429568, 2535.2774459279017, 2954.630671166104, 3042.8326442045677, 3138.5606015157896, 10012.94993525035, 10624.362538247653, 10917.39954302513, 11066.059384952288, 11120.499577519031, 1949.76602807664, 2003.9699404508945, 2009.899505024743, 2010.8491863110326, 2028.188724510193, 82906.58546707289, 86460.0, 86571.56714216451, 86610.5669471655, 87703.56148219218, 11252.831207531894, 11571.6528504145, 11587.942060289814, 11915.165938384403, 12017.759644807229, 17136.48590542286, 17193.57016074608, 17193.57016074608, 17197.484075477754, 17205.56986075358, 8428.536430496259, 8539.103394143649, 8545.529995850287, 8764.03595604483, 8998.55007249635, 8322.875156872651, 8365.414420990472, 8442.831143377098, 8573.914260857437, 8601.483910965362, 4128.772917489567, 4958.404991401055, 4983.277424773388, 5156.226566015128, 5285.735713214401, 1853.4717605482372, 1914.4448110048208, 2044.6078088636332, 2070.3892351756267, 2128.723265975413, 958.5782255807422, 973.6300205921705, 1038.9532471038822, 1042.7288904884786, 1054.773223756896, 19823.60352792936, 20114.69827952582, 20120.89939550293, 20133.19467221324, 20285.087171077335, 981.3768257156614, 1023.1763430438419, 1031.6750223679517, 1055.456439933435, 1077.439731339699, 10404.219683523766, 11394.1454390921, 11477.54089836414, 11477.598284060017, 11605.419729013516, 464196.0, 465374.0, 469385.0, 475351.0, 484513.0, 89767.55116224378, 91078.54460727653, 91561.0, 93258.0, 94464.52767736117, 972.1493693018608, 991.8115558043949, 999.715081201854, 1009.7576581620358, 1026.9435181065114, 17619.55951101233, 17808.821911780717, 18152.45542633723, 18213.089345532404, 18332.17505212242, 42028.57971420247, 42196.789016054725, 42863.0, 43317.0, 43338.56661433345, 58149.418505816095, 58967.70516147392, 59423.70288148532, 59472.0, 59494.70252648709, 8773.649054037767, 8872.201501864864, 8899.73300800977, 8917.197452229331, 9039.276857851488, 11290.096792256436, 11619.128565357463, 11836.230645008047, 11994.76010479768, 12028.458719357825, 10005.54975026111, 10048.799024019625, 10212.693619191436, 10246.333988290737, 10735.409552474377, 10062.597496100367, 10333.121684656888, 10581.312214706328, 10583.417912014913, 10774.569017239222, 10073.244506662177, 10165.542550585093, 10229.386236825814, 10547.525361358605, 10689.30519516229, 8567.700130495403, 8603.483790972561, 8718.694845680624, 8845.734627961172, 8945.515839571508, 9387.765305867408, 10733.195010374096, 10770.784584308114, 10781.02970732638, 10952.069074128789], "value": 9205.469613784175, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.3773434024881, 1531.4716422834122, 1701.7022021146304, 1785.134209908195, 1839.2642942822877, 8422.536760478171, 9046.050164732707, 9046.371653102431, 9058.094190580947, 9072.455652660828, 7846.05847298325, 8020.799480013003, 8045.637946292416, 8226.218509241628, 8847.336449766277, 2180.095260466904, 2399.3641684953413, 2459.0409740201335, 2469.592517234654, 2490.5641512735288, 2435.7807797298237, 2486.5648511510503, 2499.6125600531946, 2500.6749122614033, 2534.1003943600035, 2414.0, 2421.794147497465, 2439.8048156147556, 2440.694913135858, 2446.4006318452, 2382.523495300938, 2395.604725220328, 2399.3881560202126, 2400.1479474786547, 2404.723456802473, 2407.8916448759846, 2434.294054724128, 2447.1068060157913, 2456.9385765355833, 2461.5569197544437, 8815.647374105029, 8994.145556172152, 9002.189802917768, 9010.504422256774, 9041.68354107603, 5380.0, 5539.639923404966, 5541.390447050821, 5542.722863856831, 5549.38956714761, 3295.307985323085, 3450.8447119879665, 3514.6309637488207, 3591.6408359164134, 3615.349237137314, 1052.3422860712055, 1076.8007918535018, 1099.4173088263233, 1100.1254003067581, 1104.928179668327, 11795.351255680935, 12124.575639852563, 12152.635420937298, 12487.562935297312, 12531.436085376088, 4767.118083154627, 4817.0, 4861.854144375674, 4870.196417591129, 4985.850424487271, 9844.261680373857, 9850.556724947395, 9867.161291290176, 9869.06243906842, 9883.06110919476, 5393.217983392465, 5408.0535906216255, 5423.484768946943, 5430.049741295336, 5446.7276636168035, 4525.479569849444, 5012.097822391932, 5091.439941606421, 5097.923531147036, 5174.560162386164, 3733.4773131761576, 3924.3917192834583, 4035.6569691576547, 4046.3814474210553, 4103.261412945699, 1245.4022069406735, 1245.4893493667553, 1265.5001274496522, 1272.3765354975994, 1286.5175559165314, 736.8526294740966, 876.1545108969748, 889.6174644902754, 917.0966597901062, 924.8381533231658, 5580.609357345028, 5678.4605462480995, 5682.857928551736, 5693.68684722336, 5902.321233058167, 1003.789204267112, 1014.3457469931852, 1014.7412409835592, 1047.5914393386586, 1095.5508241621058, 3832.0, 3991.7006224533275, 4037.1118353962083, 4085.0, 4113.321301985199, 10779.838302425469, 11258.605948791754, 11332.376719280519, 11345.31928084301, 11347.716307092223, 10819.459027048617, 10926.399048052275, 11023.228374013743, 11038.503267352988, 11116.277441966246, 8228.80682301063, 8279.710210142615, 8420.62107205165, 8445.704400346081, 8485.490870547786, 5759.596828221985, 5869.413058694096, 5916.112583112567, 5966.463018328372, 5991.64050156992, 10117.140043096124, 10162.288639795144, 10232.02795734404, 10292.536835842255, 10309.123724483503, 10052.44711540843, 10227.28409011362, 10459.0, 10590.417527036087, 10598.0, 7624.8475030500185, 7749.07011158642, 7779.805504862424, 7780.299773020455, 7787.415943804351, 7701.460897737329, 7896.802579935547, 8191.426600138171, 8285.0, 8411.789705257173, 7327.780166595011, 7668.386529077772, 7688.038995125609, 7817.570033648204, 8034.95982520107, 7223.530470519399, 7269.854602907806, 7409.481336306407, 7466.887996680162, 7469.850602988018, 6715.899261511179, 6740.258571557027, 6783.253842077269, 6795.694193761194, 6806.591604503746, 4953.405591329064, 4970.27930950003, 5005.824796132263, 5044.596432285482, 5092.41437234708, 5017.197248440232, 5064.316317297265, 5176.197689358156, 5248.107821670249, 5293.655912365684], "value": 4674.386022156342, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.729168540224, 352.0898477435828, 361.4433771991134, 366.25284419783645, 366.5143684617882, 5322.92015619766, 5427.83716488506, 5438.293021907151, 5456.590755693324, 5469.261649677293, 5229.843104706865, 5317.46825317469, 5351.304330437048, 5379.38137114232, 5440.863978400542, 4281.978590107045, 4297.935530967038, 4309.461317335333, 4329.826806927719, 4359.542248063955, 4232.640225580829, 4279.26127278542, 4289.0, 4339.370791235269, 4339.587739164775, 4238.474149306247, 4240.194363071022, 4250.681198910079, 4254.149170165963, 4289.82029941767, 4256.765877876715, 4257.169851878885, 4274.871753847389, 4286.5284818669925, 4287.421198138242, 3740.719446041531, 3849.8460061597502, 3851.480050193244, 3854.113553882623, 3857.112864041258, 5235.58115350771, 5235.921461178085, 5252.240499432694, 5256.395514515842, 5313.601479889024, 4931.7040977541465, 4933.605311575066, 4974.950250497485, 4981.950180498185, 4993.6005119590345, 5499.50504454597, 5648.858778530528, 5668.858278543028, 5676.347220069703, 5705.258316418881, 4210.936835947463, 4219.346001369792, 4230.238557059728, 4236.07258697292, 4249.107687385653, 5867.413258674141, 5872.647641141545, 5888.411158884121, 5896.734646940898, 5941.405859414067, 4152.148809494047, 4292.849750258726, 4297.39836422901, 4334.978325108417, 4336.70410488025, 4382.167388196232, 4383.189110014658, 4399.316416985636, 4400.647948164204, 4409.4488188976375, 4927.728974906343, 4934.309196712463, 4949.406071271398, 4965.063625186181, 4987.152184128707, 5506.476884695948, 5666.490015898589, 5667.489925906606, 5680.920625081221, 5736.282964629421, 1437.626217183519, 1459.4527052355368, 1467.8678918897351, 1469.2139705257637, 1470.9705805883823, 998.2609698215836, 1026.7484466305802, 1037.1702637889657, 1037.5434808684154, 1046.7906418716286, 5236.9738151309, 5252.395974462909, 5276.7335839398265, 5279.41926388097, 5290.365156181283, 5558.610897237155, 5593.944060559343, 5603.3836278009385, 5635.0, 5639.082711877981, 5085.084684756779, 5285.973570132125, 5307.230451584576, 5309.787608495694, 5311.840644780663, 2963.599914011624, 2968.9406211875644, 2987.1181155871664, 2987.1785259053936, 2989.4768415527196, 5836.212111364912, 5842.357340692521, 5863.824085277449, 5895.115732640138, 5903.527717782567, 5602.982926146584, 5877.617954833007, 5878.353381128072, 5886.262887757213, 5906.822795316148, 6003.6397816131175, 6026.7890623828835, 6034.48706859913, 6036.215292012098, 6044.9395506044375, 5618.185363122406, 5743.305724811107, 5797.739101740516, 5824.184614154106, 5857.297124345106, 5756.827295181151, 5758.798442054508, 5759.12043978011, 5764.106563482667, 5764.59647824665, 5882.352941176553, 5997.940020599913, 6014.879702405839, 6033.461467325804, 6038.184845046038, 4211.515675697334, 4211.578842115764, 4245.91508169841, 4251.95748042528, 4269.957300426956, 5808.502343992124, 5826.359100498857, 5830.387809279964, 5856.0, 5901.439363260483, 5551.361593416647, 5668.5465162787705, 5712.428757124254, 5751.223584815996, 5774.451427114417, 5697.914531282117, 5706.942930570641, 5711.200431939449, 5730.341010783646, 5731.7420716067045, 5651.180578815966, 5663.348714897675, 5678.8926159398525, 5680.289963754531, 5685.260916080883, 5487.341519017584, 5681.920435117315, 5729.828105156852, 5735.512481438957, 5753.453421924911, 5581.330240371181, 5582.990123555435, 5595.468430499096, 5600.663960162403, 5607.43925607436], "value": 4363.551386320234, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.8536049530657, 821.8726097454896, 840.8360369727903, 860.4880096342675, 888.6045709659196, 14098.365573549188, 15063.548093557183, 15081.321340539675, 15092.622684432894, 15097.169655668933, 14665.266736663178, 14817.77773333401, 14844.851551484482, 14854.851451485481, 14888.925555372209, 691.2948792231921, 709.0286307758378, 822.042320696391, 853.0403296291672, 853.0488505316589, 850.4897061762923, 852.7186028610574, 855.9657613695445, 856.9400141990063, 858.0904241503995, 900.5047224026791, 900.6802585082299, 900.918917297443, 901.8782464367292, 902.3457992955088, 723.1936390924108, 745.0128579632009, 837.2590257621988, 879.8812160358334, 897.4615230861497, 652.2108249018693, 652.2499126005084, 652.3965332067866, 652.6508318049821, 652.8824811533922, 14627.976041677086, 14646.340914658866, 14673.339699713539, 14675.63310917225, 14692.926535367362, 13132.409041593151, 13222.801657975138, 13553.0, 14109.082909610945, 14114.294285285694, 12966.157199781985, 13006.219626822422, 13051.86948130516, 13233.073684842066, 13274.800877986838, 4546.818127274905, 4552.4764652065105, 4575.611073058794, 4642.466116396624, 4689.765511724434, 57128.71435642837, 58582.121268180585, 58834.0, 65993.0, 66479.99999999952, 11398.0, 11434.199606027498, 11595.420228988685, 11733.0, 12110.455029523693, 19709.40871773849, 20384.59230815405, 21186.788132118483, 21367.78632213658, 21452.356429307147, 8135.227153420416, 8489.363297752694, 8551.144885511523, 8576.099509551408, 8582.0, 4571.291449825282, 4634.23535116702, 4699.647526435463, 4802.687825291345, 4957.628177886673, 3462.913427164341, 3595.532580764484, 3612.0428086557085, 3617.8733744318824, 3622.0763705255517, 622.8972219583809, 624.3537938233997, 624.6127401011402, 630.621627023782, 638.3201889987241, 709.8899670551073, 753.9057617797775, 774.376626815419, 778.2178910195217, 795.95224286543, 8870.508555845183, 9229.215516681023, 9322.95338523303, 9590.568424420917, 9659.227261819038, 740.9626522868028, 757.5076200469739, 764.9120351159577, 775.6780935911534, 775.968961241544, 4597.885052873705, 4711.552402521755, 4717.8112875485285, 4725.50382209863, 4801.51984801517, 89354.0, 90470.0, 90782.0, 90935.0, 93881.0, 72534.0, 76648.0, 76748.0, 79992.60003699944, 80656.19343806604, 67407.3259267401, 68849.3115068853, 71252.64373678202, 72051.27948720551, 74620.0, 8886.595175593198, 9245.167934885892, 9265.490398027903, 9272.350935434455, 9276.72169834906, 48273.517264828304, 48731.0, 49179.262311064645, 50465.49534504755, 51248.23127653163, 61652.383476164665, 65813.67093164695, 66449.33550664625, 68677.0, 69306.30693692999, 11497.770044599229, 11520.654380368602, 11523.654290371302, 11666.824997624874, 11787.057035437316, 13533.052686311863, 14209.786853197003, 14446.638834029234, 14584.708305834036, 15091.471798487, 12853.100282980102, 13821.861781382058, 14204.28978551089, 14300.499482518062, 15114.697706045597, 13866.791998120238, 14017.80848627878, 14036.719265614427, 14095.436182552994, 14336.0, 13826.792598110835, 13882.305884705522, 14022.719545609234, 14130.15219086858, 14249.28753562297, 9794.706158815246, 10404.947975260075, 10548.525316360936, 10605.363678179334, 10718.35689858611, 11414.0, 11483.25358851672, 11645.59240426581, 11790.646280611596, 11921.761564768483], "value": 7417.023091710076, "unit": "score"}], "name": "dromaeo_css", "value": 7343.589688417547, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 109.0, 111.0, 110.0, 111.0, 111.0, 110.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 121.0, 151.0, 119.0, 118.0, 117.0, 116.0, 159.0, 122.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 161.0, 161.0, 159.0, 160.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 112.0, 76.0, 76.0, 75.0, 75.0, 97.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 117.0, 82.0, 82.0, 83.0, 98.0, 82.0, 82.0, 110.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 51.0, 51.0, 51.0, 52.0, 51.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 60.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 74.0, 74.0, 73.0, 74.0, 78.0, 78.0, 79.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 128.0, 122.0, 125.0, 122.0, 132.0, 123.0, 117.0, 156.0, 142.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 156.0, 153.0, 155.0, 154.0, 155.0, 152.0, 154.0, 153.0, 151.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 63.0, 62.0, 73.0, 62.0, 63.0, 61.0, 69.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1449.6, "alertThreshold": 2.0}]} 21:53:14 INFO - Return code: 0 21:53:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:53:14 INFO - # TBPL SUCCESS # 21:53:14 INFO - Running post-action listener: _resource_record_post_action 21:53:14 INFO - [mozharness: 2016-12-27 05:53:14.516506Z] Finished run-tests step (success) 21:53:14 INFO - Running post-run listener: _resource_record_post_run 21:53:14 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345841664; Read time: 8; Write time: 264692 21:53:14 INFO - TinderboxPrint: CPU usage
12.9% 21:53:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 21:53:14 INFO - TinderboxPrint: I/O write bytes / time
345,841,664 / 264,692 21:53:14 INFO - TinderboxPrint: CPU idle
8,267.3 (87.0%) 21:53:14 INFO - TinderboxPrint: CPU user
1,187.2 (12.5%) 21:53:14 INFO - TinderboxPrint: Swap in / out
0 / 0 21:53:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108236800; Read time: 0; Write time: 106700 21:53:14 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 237268992; Read time: 0; Write time: 157988 21:53:15 INFO - Running post-run listener: _upload_blobber_files 21:53:15 INFO - Blob upload gear active. 21:53:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:53:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:53:15 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'] 21:53:15 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 21:53:15 INFO - (blobuploader) - INFO - Open directory for files ... 21:53:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:53:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:53:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:53:16 INFO - (blobuploader) - INFO - Done attempting. 21:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:53:17 INFO - (blobuploader) - INFO - Done attempting. 21:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:53:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:53:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:53:20 INFO - (blobuploader) - INFO - Done attempting. 21:53:20 INFO - (blobuploader) - INFO - Iteration through files over. 21:53:20 INFO - Return code: 0 21:53:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:53:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:53:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd03091c17c06a4c1fc57d17ee75b481639074c2ef7aaf47ff28110822982db2213db35bbdd1080148bcf9eb54b0d27fd870b321826af340d2ec32ee6217135b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98de2da87850faf41c530574aabd0e1f22b63e933da30b8e3b411023ea24914ef23d7697463121da9e8bcfaa8abdb9e2cc4f2a647262e6c7aecc7f4b3b84a2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84d751f24a9e231ab19c3858d3dc0463c5ec208bb42dae17f42b1fc9b1c02d15d2add41fb72c7a954c88124cecacfc4603b2060a38a73548a8aebb110065bfb6"} 21:53:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:53:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:53:20 INFO - Contents: 21:53:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd03091c17c06a4c1fc57d17ee75b481639074c2ef7aaf47ff28110822982db2213db35bbdd1080148bcf9eb54b0d27fd870b321826af340d2ec32ee6217135b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98de2da87850faf41c530574aabd0e1f22b63e933da30b8e3b411023ea24914ef23d7697463121da9e8bcfaa8abdb9e2cc4f2a647262e6c7aecc7f4b3b84a2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84d751f24a9e231ab19c3858d3dc0463c5ec208bb42dae17f42b1fc9b1c02d15d2add41fb72c7a954c88124cecacfc4603b2060a38a73548a8aebb110065bfb6"} 21:53:20 INFO - Running post-run listener: copy_logs_to_upload_dir 21:53:20 INFO - Copying logs to upload dir... 21:53:20 INFO - mkdir: /builds/slave/test/build/upload/logs 21:53:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.729755 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-26 21:53:19.376205) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-26 21:53:19.379997) ========= 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=62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657 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/dd03091c17c06a4c1fc57d17ee75b481639074c2ef7aaf47ff28110822982db2213db35bbdd1080148bcf9eb54b0d27fd870b321826af340d2ec32ee6217135b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98de2da87850faf41c530574aabd0e1f22b63e933da30b8e3b411023ea24914ef23d7697463121da9e8bcfaa8abdb9e2cc4f2a647262e6c7aecc7f4b3b84a2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84d751f24a9e231ab19c3858d3dc0463c5ec208bb42dae17f42b1fc9b1c02d15d2add41fb72c7a954c88124cecacfc4603b2060a38a73548a8aebb110065bfb6"} build_url:https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011782 build_url: 'https://queue.taskcluster.net/v1/task/Mrh4orkBT1-SmU7BnVARLg/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/dd03091c17c06a4c1fc57d17ee75b481639074c2ef7aaf47ff28110822982db2213db35bbdd1080148bcf9eb54b0d27fd870b321826af340d2ec32ee6217135b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98de2da87850faf41c530574aabd0e1f22b63e933da30b8e3b411023ea24914ef23d7697463121da9e8bcfaa8abdb9e2cc4f2a647262e6c7aecc7f4b3b84a2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84d751f24a9e231ab19c3858d3dc0463c5ec208bb42dae17f42b1fc9b1c02d15d2add41fb72c7a954c88124cecacfc4603b2060a38a73548a8aebb110065bfb6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-26 21:53:19.409267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:53:19.409606) ========= 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=62c568580acbfdaac3eec7be000001dc-1482816058.757611-167521657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-26 21:53:19.494180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-26 21:53:19.494893) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-26 21:53:19.495549) ========= ========= Total master_lag: 0.18 =========