builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1475685006.02 results: success (0) buildid: 20161005080902 builduid: 1169375398184687a4f7d21c52b799ae revision: 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.016859) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.017320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.017605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.035161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.035530) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 09:30:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-10-05 09:30:06 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121043 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.170407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.170770) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014022 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.220418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.220867) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 --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=337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 09:30:06,527 truncating revision to first 12 chars 2016-10-05 09:30:06,527 Setting DEBUG logging. 2016-10-05 09:30:06,527 attempt 1/10 2016-10-05 09:30:06,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4f41a594f88d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 09:30:06,844 unpacking tar archive at: fx-team-4f41a594f88d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637554 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.872580) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.872911) ========= script_repo_revision: 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.873359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.873663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 09:30:06.882711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-05 09:30:06.883114) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:30:07 INFO - MultiFileLogger online at 20161005 09:30:07 in /builds/slave/test 09:30:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:30:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:30:07 INFO - {'append_to_log': False, 09:30:07 INFO - 'base_work_dir': '/builds/slave/test', 09:30:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:30:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:30:07 INFO - 'branch': 'Fx-Team-Non-PGO', 09:30:07 INFO - 'buildbot_json_path': 'buildprops.json', 09:30:07 INFO - 'config_files': ('talos/linux_config.py',), 09:30:07 INFO - 'default_actions': ('clobber', 09:30:07 INFO - 'read-buildbot-config', 09:30:07 INFO - 'download-and-extract', 09:30:07 INFO - 'populate-webroot', 09:30:07 INFO - 'create-virtualenv', 09:30:07 INFO - 'install', 09:30:07 INFO - 'run-tests'), 09:30:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:30:07 INFO - 'download_minidump_stackwalk': True, 09:30:07 INFO - 'download_symbols': 'ondemand', 09:30:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:30:07 INFO - 'tooltool.py': '/tools/tooltool.py', 09:30:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:30:07 INFO - '/tools/misc-python/virtualenv.py')}, 09:30:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:30:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:30:07 INFO - 'installer_path': 'installer.exe', 09:30:07 INFO - 'log_level': 'info', 09:30:07 INFO - 'log_name': 'talos', 09:30:07 INFO - 'log_to_console': True, 09:30:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:30:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:30:07 INFO - 'opt_config_files': (), 09:30:07 INFO - 'pip_index': False, 09:30:07 INFO - 'sps_profile': False, 09:30:07 INFO - 'sps_profile_interval': 0, 09:30:07 INFO - 'suite': 'dromaeojs', 09:30:07 INFO - 'system_bits': '32', 09:30:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:30:07 INFO - 'title': 'talos-linux64-ix-060', 09:30:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:30:07 INFO - 'use_talos_json': True, 09:30:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:30:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:30:07 INFO - 'work_dir': 'build'} 09:30:07 INFO - [mozharness: 2016-10-05 16:30:07.288298Z] Running clobber step. 09:30:07 INFO - Running pre-action listener: _resource_record_pre_action 09:30:07 INFO - Running main action method: clobber 09:30:07 INFO - rmtree: /builds/slave/test/build 09:30:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:30:07 INFO - Running post-action listener: _resource_record_post_action 09:30:07 INFO - [mozharness: 2016-10-05 16:30:07.743290Z] Finished clobber step (success) 09:30:07 INFO - [mozharness: 2016-10-05 16:30:07.743391Z] Running read-buildbot-config step. 09:30:07 INFO - Running pre-action listener: _resource_record_pre_action 09:30:07 INFO - Running main action method: read_buildbot_config 09:30:07 INFO - Using buildbot properties: 09:30:07 INFO - { 09:30:07 INFO - "project": "", 09:30:07 INFO - "product": "firefox", 09:30:07 INFO - "script_repo_revision": "production", 09:30:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:30:07 INFO - "repository": "", 09:30:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:30:07 INFO - "buildid": "20161005080902", 09:30:07 INFO - "pgo_build": "False", 09:30:07 INFO - "basedir": "/builds/slave/test", 09:30:07 INFO - "buildnumber": 2196, 09:30:07 INFO - "slavename": "talos-linux64-ix-060", 09:30:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:30:07 INFO - "platform": "ubuntu64_hw", 09:30:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:30:07 INFO - "branch": "fx-team", 09:30:07 INFO - "repo_path": "integration/fx-team", 09:30:07 INFO - "revision": "4f41a594f88d17e25bbfd362f2e45e6dc891bfc6", 09:30:07 INFO - "stage_platform": "linux64", 09:30:07 INFO - "builduid": "1169375398184687a4f7d21c52b799ae", 09:30:07 INFO - "slavebuilddir": "test" 09:30:07 INFO - } 09:30:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:30:07 INFO - Running post-action listener: _resource_record_post_action 09:30:07 INFO - [mozharness: 2016-10-05 16:30:07.745817Z] Finished read-buildbot-config step (success) 09:30:07 INFO - [mozharness: 2016-10-05 16:30:07.745917Z] Running download-and-extract step. 09:30:07 INFO - Running pre-action listener: _resource_record_pre_action 09:30:07 INFO - Running main action method: download_and_extract 09:30:07 INFO - mkdir: /builds/slave/test/build/tests 09:30: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')]} 09:30:07 INFO - trying https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:30:07 INFO - Downloading https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:30:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:30:08 INFO - Downloaded 1361 bytes. 09:30:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:30:08 INFO - Using the following test package requirements: 09:30:08 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:08 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:30:08 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:30:08 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:08 INFO - u'jsshell-linux-x86_64.zip'], 09:30:08 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:30:08 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:30:08 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:30:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:30:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:30:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:30:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:30:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:30:08 INFO - Fetch https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:30:08 INFO - Http code: 200 09:30:08 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 09:30:08 INFO - x-amz-cf-id: CQ_xAPbhjgLSX4n4YFU8r-bm1Kirxc47FuVW2gi6OFAsTj7WiH7zPg== 09:30:08 INFO - x-amz-version-id: Ie_3S3zPZfKW_36DpoXwgAUEJq_qwazJ 09:30:09 INFO - Expected file size: 20421402 09:30:09 INFO - Obtained file size: 20421402 09:30:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:30:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:30:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:30:13 INFO - Fetch https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:30:13 INFO - Http code: 200 09:30:13 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 09:30:13 INFO - x-amz-cf-id: 24Xa6PdIpQezgGlMWRKmlIMe6KTMglfBf5vJC6EK1l0LFjSiglWagA== 09:30:13 INFO - x-amz-version-id: Ie_3S3zPZfKW_36DpoXwgAUEJq_qwazJ 09:30:14 INFO - Expected file size: 20421402 09:30:14 INFO - Obtained file size: 20421402 09:30:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:30:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:30:18 INFO - Fetch https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:30:18 INFO - Http code: 200 09:30:18 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 09:30:18 INFO - x-amz-cf-id: G5H1xTN2SBwGLkTPAfYqWYD2olRpnvtbwasaz89B6NYMt1Cg6oONuA== 09:30:18 INFO - x-amz-version-id: FPfj_6zs73bw1nAoVyzmCCcknIw_IW1g 09:30:19 INFO - Expected file size: 14409006 09:30:19 INFO - Obtained file size: 14409006 09:30: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')]} 09:30:19 INFO - trying https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:30:19 INFO - Downloading https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:30:20 INFO - Downloaded 55810605 bytes. 09:30:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:30:20 INFO - mkdir: /builds/slave/test/properties 09:30:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:30:20 INFO - Writing to file /builds/slave/test/properties/build_url 09:30:20 INFO - Contents: 09:30:20 INFO - build_url:https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:30:21 INFO - Running post-action listener: _resource_record_post_action 09:30:21 INFO - Running post-action listener: set_extra_try_arguments 09:30:21 INFO - [mozharness: 2016-10-05 16:30:21.192278Z] Finished download-and-extract step (success) 09:30:21 INFO - [mozharness: 2016-10-05 16:30:21.192503Z] Running populate-webroot step. 09:30:21 INFO - Running pre-action listener: _resource_record_pre_action 09:30:21 INFO - Running main action method: populate_webroot 09:30:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:30:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:30:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:30:21 INFO - '--tppagecycles', 09:30:21 INFO - '7'], 09:30:21 INFO - 'tests': ['tsvgm']}}, 09:30:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:30:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:30:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:30:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:30:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:21 INFO - 'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:21 INFO - 'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['damp', 'tps']}, 09:30:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:21 INFO - 'tests': ['damp', 'tps']}, 09:30:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['dromaeo_dom']}, 09:30:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:30:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['basic_compositor_video']}, 09:30:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:30:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['a11yr', 09:30:21 INFO - 'ts_paint', 09:30:21 INFO - 'tpaint', 09:30:21 INFO - 'sessionrestore', 09:30:21 INFO - 'sessionrestore_no_auto_restore', 09:30:21 INFO - 'tabpaint']}, 09:30:21 INFO - 'other-e10s': {'tests': ['a11yr', 09:30:21 INFO - 'ts_paint', 09:30:21 INFO - 'tpaint', 09:30:21 INFO - 'sessionrestore', 09:30:21 INFO - 'sessionrestore_no_auto_restore', 09:30:21 INFO - 'tabpaint']}, 09:30:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:30:21 INFO - 'ts_paint', 09:30:21 INFO - 'tpaint', 09:30:21 INFO - 'sessionrestore', 09:30:21 INFO - 'sessionrestore_no_auto_restore', 09:30:21 INFO - 'tabpaint']}, 09:30:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:30:21 INFO - 'ts_paint', 09:30:21 INFO - 'tpaint', 09:30:21 INFO - 'sessionrestore', 09:30:21 INFO - 'sessionrestore_no_auto_restore', 09:30:21 INFO - 'tabpaint']}, 09:30:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['a11yr', 09:30:21 INFO - 'ts_paint', 09:30:21 INFO - 'tpaint', 09:30:21 INFO - 'sessionrestore', 09:30:21 INFO - 'sessionrestore_no_auto_restore', 09:30:21 INFO - 'tabpaint']}, 09:30:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['a11yr', 09:30:21 INFO - 'ts_paint', 09:30:21 INFO - 'tpaint', 09:30:21 INFO - 'sessionrestore', 09:30:21 INFO - 'sessionrestore_no_auto_restore', 09:30:21 INFO - 'tabpaint']}, 09:30:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['tsvgx', 09:30:21 INFO - 'tsvgr_opacity', 09:30:21 INFO - 'tart', 09:30:21 INFO - 'tscrollx', 09:30:21 INFO - 'cart']}, 09:30:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:30:21 INFO - 'tsvgr_opacity', 09:30:21 INFO - 'tart', 09:30:21 INFO - 'tscrollx', 09:30:21 INFO - 'cart']}, 09:30:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:21 INFO - 'talos_options': ['--disable-e10s'], 09:30:21 INFO - 'tests': ['tp5o']}, 09:30:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:21 INFO - 'tests': ['tp5o']}, 09:30:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:21 INFO - 'talos_options': ['--disable-e10s', 09:30:21 INFO - '--xperf_path', 09:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:21 INFO - 'tests': ['tp5n']}, 09:30:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:21 INFO - 'talos_options': ['--xperf_path', 09:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:21 INFO - 'tests': ['tp5n']}}, 09:30:21 INFO - 'talos.zip': {'path': '', 09:30:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:30:21 INFO - Running post-action listener: _resource_record_post_action 09:30:21 INFO - [mozharness: 2016-10-05 16:30:21.214192Z] Finished populate-webroot step (success) 09:30:21 INFO - [mozharness: 2016-10-05 16:30:21.214280Z] Running create-virtualenv step. 09:30:21 INFO - Running pre-action listener: _resource_record_pre_action 09:30:21 INFO - Running main action method: create_virtualenv 09:30:21 INFO - Creating virtualenv /builds/slave/test/build/venv 09:30:21 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 09:30:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:30:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:30:21 INFO - Using real prefix '/usr' 09:30:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:30:21 INFO - Installing distribute.............................................................................................................................................................................................done. 09:30:23 INFO - Installing pip.................done. 09:30:23 INFO - Return code: 0 09:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:30:24 INFO - Reading from file tmpfile_stdout 09:30:24 INFO - Output received: 09:30:24 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) 09:30:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:30:24 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')]} 09:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:24 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')]} 09:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:24 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 0x7faaf01d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', '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 09:30:24 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 09:30:24 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 09:30:24 INFO - Using env: {'DISPLAY': ':0', 09:30:24 INFO - 'HOME': '/home/cltbld', 09:30:24 INFO - 'LANG': 'en_US.UTF-8', 09:30:24 INFO - 'LANGUAGE': 'en_US:en', 09:30:24 INFO - 'LOGNAME': 'cltbld', 09:30:24 INFO - 'MAIL': '/var/mail/cltbld', 09:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:24 INFO - 'MOZ_NO_REMOTE': '1', 09:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:24 INFO - 'NO_EM_RESTART': '1', 09:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:24 INFO - 'PWD': '/builds/slave/test', 09:30:24 INFO - 'SHELL': '/bin/bash', 09:30:24 INFO - 'SHLVL': '1', 09:30:24 INFO - 'TERM': 'linux', 09:30:24 INFO - 'TMOUT': '86400', 09:30:24 INFO - 'USER': 'cltbld', 09:30:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:24 INFO - '_': '/tools/buildbot/bin/python'} 09:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:24 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 09:30:24 INFO - Cleaning up... 09:30:24 INFO - Return code: 0 09:30:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:30:24 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')]} 09:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:24 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')]} 09:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:24 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 0x7faaf01d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', '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 09:30:24 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 09:30:24 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 09:30:24 INFO - Using env: {'DISPLAY': ':0', 09:30:24 INFO - 'HOME': '/home/cltbld', 09:30:24 INFO - 'LANG': 'en_US.UTF-8', 09:30:24 INFO - 'LANGUAGE': 'en_US:en', 09:30:24 INFO - 'LOGNAME': 'cltbld', 09:30:24 INFO - 'MAIL': '/var/mail/cltbld', 09:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:24 INFO - 'MOZ_NO_REMOTE': '1', 09:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:24 INFO - 'NO_EM_RESTART': '1', 09:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:24 INFO - 'PWD': '/builds/slave/test', 09:30:24 INFO - 'SHELL': '/bin/bash', 09:30:24 INFO - 'SHLVL': '1', 09:30:24 INFO - 'TERM': 'linux', 09:30:24 INFO - 'TMOUT': '86400', 09:30:24 INFO - 'USER': 'cltbld', 09:30:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:24 INFO - '_': '/tools/buildbot/bin/python'} 09:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:24 INFO - Downloading/unpacking psutil>=3.1.1 09:30:24 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 09:30:24 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 09:30:24 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 09:30:24 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 09:30:24 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 09:30:24 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 09:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:30:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:26 INFO - Installing collected packages: psutil 09:30:26 INFO - Running setup.py install for psutil 09:30:26 INFO - building 'psutil._psutil_linux' extension 09:30:26 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 09:30:26 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 09:30:26 INFO - building 'psutil._psutil_posix' extension 09:30:26 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 09:30:26 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 09:30:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:26 INFO - Successfully installed psutil 09:30:26 INFO - Cleaning up... 09:30:27 INFO - Return code: 0 09:30:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf01d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', '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 09:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:30:27 INFO - Using env: {'DISPLAY': ':0', 09:30:27 INFO - 'HOME': '/home/cltbld', 09:30:27 INFO - 'LANG': 'en_US.UTF-8', 09:30:27 INFO - 'LANGUAGE': 'en_US:en', 09:30:27 INFO - 'LOGNAME': 'cltbld', 09:30:27 INFO - 'MAIL': '/var/mail/cltbld', 09:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:27 INFO - 'MOZ_NO_REMOTE': '1', 09:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:27 INFO - 'NO_EM_RESTART': '1', 09:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:27 INFO - 'PWD': '/builds/slave/test', 09:30:27 INFO - 'SHELL': '/bin/bash', 09:30:27 INFO - 'SHLVL': '1', 09:30:27 INFO - 'TERM': 'linux', 09:30:27 INFO - 'TMOUT': '86400', 09:30:27 INFO - 'USER': 'cltbld', 09:30:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:27 INFO - '_': '/tools/buildbot/bin/python'} 09:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:30:27 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 09:30:27 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 09:30:27 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 09:30:27 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 09:30:27 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 09:30:27 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 09:30:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:30:29 INFO - Installing collected packages: mozsystemmonitor 09:30:29 INFO - Running setup.py install for mozsystemmonitor 09:30:29 INFO - Successfully installed mozsystemmonitor 09:30:29 INFO - Cleaning up... 09:30:29 INFO - Return code: 0 09:30:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:30:29 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')]} 09:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:29 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')]} 09:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:29 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 0x7faaf01d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', '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 09:30:29 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 09:30:29 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 09:30:29 INFO - Using env: {'DISPLAY': ':0', 09:30:29 INFO - 'HOME': '/home/cltbld', 09:30:29 INFO - 'LANG': 'en_US.UTF-8', 09:30:29 INFO - 'LANGUAGE': 'en_US:en', 09:30:29 INFO - 'LOGNAME': 'cltbld', 09:30:29 INFO - 'MAIL': '/var/mail/cltbld', 09:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:29 INFO - 'MOZ_NO_REMOTE': '1', 09:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:29 INFO - 'NO_EM_RESTART': '1', 09:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:29 INFO - 'PWD': '/builds/slave/test', 09:30:29 INFO - 'SHELL': '/bin/bash', 09:30:29 INFO - 'SHLVL': '1', 09:30:29 INFO - 'TERM': 'linux', 09:30:29 INFO - 'TMOUT': '86400', 09:30:29 INFO - 'USER': 'cltbld', 09:30:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:29 INFO - '_': '/tools/buildbot/bin/python'} 09:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:29 INFO - Downloading/unpacking jsonschema==2.5.1 09:30:29 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 09:30:29 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 09:30:29 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 09:30:29 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 09:30:29 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 09:30:29 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 09:30:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:30:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:31 INFO - Downloading functools32-3.2.3-2.tar.gz 09:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:30:31 INFO - warning: no files found matching '*.txt' 09:30:31 INFO - no previously-included directories found matching 'build' 09:30:31 INFO - no previously-included directories found matching 'dist' 09:30:31 INFO - no previously-included directories found matching '.git*' 09:30:31 INFO - Installing collected packages: jsonschema, functools32 09:30:31 INFO - Running setup.py install for functools32 09:30:31 INFO - warning: no files found matching '*.txt' 09:30:31 INFO - no previously-included directories found matching 'build' 09:30:31 INFO - no previously-included directories found matching 'dist' 09:30:31 INFO - no previously-included directories found matching '.git*' 09:30:31 INFO - Successfully installed jsonschema functools32 09:30:31 INFO - Cleaning up... 09:30:31 INFO - Return code: 0 09:30:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:30:31 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')]} 09:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:31 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')]} 09:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:31 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 0x7faaf01d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', '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 09:30:31 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 09:30:31 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 09:30:31 INFO - Using env: {'DISPLAY': ':0', 09:30:31 INFO - 'HOME': '/home/cltbld', 09:30:31 INFO - 'LANG': 'en_US.UTF-8', 09:30:31 INFO - 'LANGUAGE': 'en_US:en', 09:30:31 INFO - 'LOGNAME': 'cltbld', 09:30:31 INFO - 'MAIL': '/var/mail/cltbld', 09:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:31 INFO - 'MOZ_NO_REMOTE': '1', 09:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:31 INFO - 'NO_EM_RESTART': '1', 09:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:31 INFO - 'PWD': '/builds/slave/test', 09:30:31 INFO - 'SHELL': '/bin/bash', 09:30:31 INFO - 'SHLVL': '1', 09:30:31 INFO - 'TERM': 'linux', 09:30:31 INFO - 'TMOUT': '86400', 09:30:31 INFO - 'USER': 'cltbld', 09:30:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:31 INFO - '_': '/tools/buildbot/bin/python'} 09:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:30:32 INFO - Cleaning up... 09:30:32 INFO - Return code: 0 09:30:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:30:32 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')]} 09:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:32 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')]} 09:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:32 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 0x7faaf01d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', '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 09:30:32 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 09:30:32 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 09:30:32 INFO - Using env: {'DISPLAY': ':0', 09:30:32 INFO - 'HOME': '/home/cltbld', 09:30:32 INFO - 'LANG': 'en_US.UTF-8', 09:30:32 INFO - 'LANGUAGE': 'en_US:en', 09:30:32 INFO - 'LOGNAME': 'cltbld', 09:30:32 INFO - 'MAIL': '/var/mail/cltbld', 09:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:32 INFO - 'MOZ_NO_REMOTE': '1', 09:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:32 INFO - 'NO_EM_RESTART': '1', 09:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:32 INFO - 'PWD': '/builds/slave/test', 09:30:32 INFO - 'SHELL': '/bin/bash', 09:30:32 INFO - 'SHLVL': '1', 09:30:32 INFO - 'TERM': 'linux', 09:30:32 INFO - 'TMOUT': '86400', 09:30:32 INFO - 'USER': 'cltbld', 09:30:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:32 INFO - '_': '/tools/buildbot/bin/python'} 09:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:30:32 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 09:30:32 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 09:30:32 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 09:30:32 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 09:30:32 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 09:30:32 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 09:30:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:30:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:30:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 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 09:30:34 INFO - Downloading docopt-0.6.1.tar.gz 09:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:30:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:30:35 INFO - Running setup.py install for blobuploader 09:30:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:30:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:30:35 INFO - Running setup.py install for requests 09:30:35 INFO - Running setup.py install for docopt 09:30:35 INFO - Successfully installed blobuploader requests docopt 09:30:35 INFO - Cleaning up... 09:30:35 INFO - Return code: 0 09:30:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:35 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 0x7faaf01d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', '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 09:30:35 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 09:30:35 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 09:30:35 INFO - Using env: {'DISPLAY': ':0', 09:30:35 INFO - 'HOME': '/home/cltbld', 09:30:35 INFO - 'LANG': 'en_US.UTF-8', 09:30:35 INFO - 'LANGUAGE': 'en_US:en', 09:30:35 INFO - 'LOGNAME': 'cltbld', 09:30:35 INFO - 'MAIL': '/var/mail/cltbld', 09:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:35 INFO - 'MOZ_NO_REMOTE': '1', 09:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:35 INFO - 'NO_EM_RESTART': '1', 09:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:35 INFO - 'PWD': '/builds/slave/test', 09:30:35 INFO - 'SHELL': '/bin/bash', 09:30:35 INFO - 'SHLVL': '1', 09:30:35 INFO - 'TERM': 'linux', 09:30:35 INFO - 'TMOUT': '86400', 09:30:35 INFO - 'USER': 'cltbld', 09:30:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:35 INFO - '_': '/tools/buildbot/bin/python'} 09:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:35 INFO - Running setup.py (path:/tmp/pip-ODT6Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:35 INFO - Running setup.py (path:/tmp/pip-KBXQtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:35 INFO - Running setup.py (path:/tmp/pip-e8tI12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:36 INFO - Running setup.py (path:/tmp/pip-JQtBzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:36 INFO - Running setup.py (path:/tmp/pip-9hkoDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:36 INFO - Running setup.py (path:/tmp/pip-UtgtPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:36 INFO - Running setup.py (path:/tmp/pip-QYn821-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:36 INFO - Running setup.py (path:/tmp/pip-Y39vRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:36 INFO - Running setup.py (path:/tmp/pip-Jq_oYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:36 INFO - Running setup.py (path:/tmp/pip-i54Z7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:36 INFO - Running setup.py (path:/tmp/pip-LZFqwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:36 INFO - Running setup.py (path:/tmp/pip-gtwuAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:36 INFO - Running setup.py (path:/tmp/pip-SB8b6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:36 INFO - Running setup.py (path:/tmp/pip-anolSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:36 INFO - Running setup.py (path:/tmp/pip-7_UvFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:36 INFO - Running setup.py (path:/tmp/pip-3dNDbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:36 INFO - Running setup.py (path:/tmp/pip-ERxxmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:30:37 INFO - Running setup.py install for manifestparser 09:30:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:30:37 INFO - Running setup.py install for mozcrash 09:30:37 INFO - Running setup.py install for mozdebug 09:30:37 INFO - Running setup.py install for mozdevice 09:30:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:30:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:30:37 INFO - Running setup.py install for mozfile 09:30:37 INFO - Running setup.py install for mozhttpd 09:30:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:30:37 INFO - Running setup.py install for mozinfo 09:30:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:30:37 INFO - Running setup.py install for mozInstall 09:30:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:30:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:30:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:30:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:30:37 INFO - Running setup.py install for mozleak 09:30:37 INFO - Running setup.py install for mozlog 09:30:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:30:38 INFO - Running setup.py install for moznetwork 09:30:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:30:38 INFO - Running setup.py install for mozprocess 09:30:38 INFO - Running setup.py install for mozprofile 09:30:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:30:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:30:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:30:38 INFO - Running setup.py install for mozrunner 09:30:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:30:38 INFO - Running setup.py install for mozscreenshot 09:30:38 INFO - Running setup.py install for moztest 09:30:38 INFO - Running setup.py install for mozversion 09:30:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:30:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:30:38 INFO - Cleaning up... 09:30:38 INFO - Return code: 0 09:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:38 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 0x7faaf01d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', '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 09:30:38 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 09:30:38 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 09:30:38 INFO - Using env: {'DISPLAY': ':0', 09:30:38 INFO - 'HOME': '/home/cltbld', 09:30:38 INFO - 'LANG': 'en_US.UTF-8', 09:30:38 INFO - 'LANGUAGE': 'en_US:en', 09:30:38 INFO - 'LOGNAME': 'cltbld', 09:30:38 INFO - 'MAIL': '/var/mail/cltbld', 09:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:38 INFO - 'MOZ_NO_REMOTE': '1', 09:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:38 INFO - 'NO_EM_RESTART': '1', 09:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:38 INFO - 'PWD': '/builds/slave/test', 09:30:38 INFO - 'SHELL': '/bin/bash', 09:30:38 INFO - 'SHLVL': '1', 09:30:38 INFO - 'TERM': 'linux', 09:30:38 INFO - 'TMOUT': '86400', 09:30:38 INFO - 'USER': 'cltbld', 09:30:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:38 INFO - '_': '/tools/buildbot/bin/python'} 09:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:39 INFO - Running setup.py (path:/tmp/pip-XxMtqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:39 INFO - Running setup.py (path:/tmp/pip-Dme2Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:39 INFO - Running setup.py (path:/tmp/pip-Dga4aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:39 INFO - Running setup.py (path:/tmp/pip-ipCMSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:39 INFO - Running setup.py (path:/tmp/pip-o8U7jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:39 INFO - Running setup.py (path:/tmp/pip-pprwfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:39 INFO - Running setup.py (path:/tmp/pip-sl7DXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:39 INFO - Running setup.py (path:/tmp/pip-7fo0By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:39 INFO - Running setup.py (path:/tmp/pip-xaxP4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:39 INFO - Running setup.py (path:/tmp/pip-hWh3OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:39 INFO - Running setup.py (path:/tmp/pip-mjiO5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:39 INFO - Running setup.py (path:/tmp/pip-VC3MS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:39 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)) 09:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:39 INFO - Running setup.py (path:/tmp/pip-o1vxOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:40 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)) 09:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:40 INFO - Running setup.py (path:/tmp/pip-gXIllc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:40 INFO - Running setup.py (path:/tmp/pip-DMuaqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:40 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)) 09:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:40 INFO - Running setup.py (path:/tmp/pip-y8AmhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:40 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)) 09:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:40 INFO - Running setup.py (path:/tmp/pip-IQcc4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:40 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)) 09:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:30:40 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)) 09:30:40 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)) 09:30:40 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)) 09:30:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:40 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 09:30:40 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 09:30:40 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 09:30:40 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 09:30:40 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 09:30:40 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 09:30:42 INFO - Downloading blessings-1.6.tar.gz 09:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:30:42 INFO - Installing collected packages: blessings 09:30:42 INFO - Running setup.py install for blessings 09:30:42 INFO - Successfully installed blessings 09:30:42 INFO - Cleaning up... 09:30:42 INFO - Return code: 0 09:30:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:30:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:42 INFO - Reading from file tmpfile_stdout 09:30:42 INFO - Current package versions: 09:30:42 INFO - argparse == 1.2.1 09:30:42 INFO - blessings == 1.6 09:30:42 INFO - blobuploader == 1.2.4 09:30:42 INFO - docopt == 0.6.1 09:30:42 INFO - functools32 == 3.2.3-2 09:30:42 INFO - jsonschema == 2.5.1 09:30:42 INFO - manifestparser == 1.1 09:30:42 INFO - mozInstall == 1.12 09:30:42 INFO - mozcrash == 0.17 09:30:42 INFO - mozdebug == 0.1 09:30:42 INFO - mozdevice == 0.48 09:30:42 INFO - mozfile == 1.2 09:30:42 INFO - mozhttpd == 0.7 09:30:42 INFO - mozinfo == 0.9 09:30:42 INFO - mozleak == 0.1 09:30:42 INFO - mozlog == 3.4 09:30:42 INFO - moznetwork == 0.27 09:30:42 INFO - mozprocess == 0.23 09:30:42 INFO - mozprofile == 0.28 09:30:42 INFO - mozrunner == 6.12 09:30:42 INFO - mozscreenshot == 0.1 09:30:42 INFO - mozsystemmonitor == 0.3 09:30:42 INFO - moztest == 0.7 09:30:42 INFO - mozversion == 1.4 09:30:42 INFO - psutil == 3.1.1 09:30:42 INFO - requests == 1.2.3 09:30:42 INFO - wsgiref == 0.1.2 09:30:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:42 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 0x7faaf01d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', '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 09:30:42 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 09:30:42 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 09:30:42 INFO - Using env: {'DISPLAY': ':0', 09:30:42 INFO - 'HOME': '/home/cltbld', 09:30:42 INFO - 'LANG': 'en_US.UTF-8', 09:30:42 INFO - 'LANGUAGE': 'en_US:en', 09:30:42 INFO - 'LOGNAME': 'cltbld', 09:30:42 INFO - 'MAIL': '/var/mail/cltbld', 09:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:42 INFO - 'MOZ_NO_REMOTE': '1', 09:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:42 INFO - 'NO_EM_RESTART': '1', 09:30:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:42 INFO - 'PWD': '/builds/slave/test', 09:30:42 INFO - 'SHELL': '/bin/bash', 09:30:42 INFO - 'SHLVL': '1', 09:30:42 INFO - 'TERM': 'linux', 09:30:42 INFO - 'TMOUT': '86400', 09:30:42 INFO - 'USER': 'cltbld', 09:30:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:42 INFO - '_': '/tools/buildbot/bin/python'} 09:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:42 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)) 09:30:42 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)) 09:30:42 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)) 09:30:42 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)) 09:30:42 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)) 09:30:42 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)) 09:30:42 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)) 09:30:42 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)) 09:30:42 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)) 09:30:42 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)) 09:30:42 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)) 09:30:42 INFO - Cleaning up... 09:30:42 INFO - Return code: 0 09:30:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:42 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 0x7faaf01d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', '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 09:30:42 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 09:30:42 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 09:30:42 INFO - Using env: {'DISPLAY': ':0', 09:30:42 INFO - 'HOME': '/home/cltbld', 09:30:42 INFO - 'LANG': 'en_US.UTF-8', 09:30:42 INFO - 'LANGUAGE': 'en_US:en', 09:30:42 INFO - 'LOGNAME': 'cltbld', 09:30:42 INFO - 'MAIL': '/var/mail/cltbld', 09:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:42 INFO - 'MOZ_NO_REMOTE': '1', 09:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:42 INFO - 'NO_EM_RESTART': '1', 09:30:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:42 INFO - 'PWD': '/builds/slave/test', 09:30:42 INFO - 'SHELL': '/bin/bash', 09:30:42 INFO - 'SHLVL': '1', 09:30:42 INFO - 'TERM': 'linux', 09:30:42 INFO - 'TMOUT': '86400', 09:30:42 INFO - 'USER': 'cltbld', 09:30:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:42 INFO - '_': '/tools/buildbot/bin/python'} 09:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:30:43 INFO - Cleaning up... 09:30:43 INFO - Return code: 0 09:30:43 INFO - Running post-action listener: _resource_record_post_action 09:30:43 INFO - Running post-action listener: _start_resource_monitoring 09:30:43 INFO - Starting resource monitoring. 09:30:43 INFO - [mozharness: 2016-10-05 16:30:43.217384Z] Finished create-virtualenv step (success) 09:30:43 INFO - [mozharness: 2016-10-05 16:30:43.217847Z] Running install step. 09:30:43 INFO - Running pre-action listener: _resource_record_pre_action 09:30:43 INFO - Running main action method: install 09:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:43 INFO - Reading from file tmpfile_stdout 09:30:43 INFO - Detecting whether we're running mozinstall >=1.0... 09:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:30:43 INFO - Reading from file tmpfile_stdout 09:30:43 INFO - Output received: 09:30:43 INFO - Usage: mozinstall [options] installer 09:30:43 INFO - Options: 09:30:43 INFO - -h, --help show this help message and exit 09:30:43 INFO - -d DEST, --destination=DEST 09:30:43 INFO - Directory to install application into. [default: 09:30:43 INFO - "/builds/slave/test"] 09:30:43 INFO - --app=APP Application being installed. [default: firefox] 09:30:43 INFO - mkdir: /builds/slave/test/build/application 09:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:30:59 INFO - Reading from file tmpfile_stdout 09:30:59 INFO - Output received: 09:30:59 INFO - /builds/slave/test/build/application/firefox/firefox 09:30:59 INFO - Running post-action listener: _resource_record_post_action 09:30:59 INFO - [mozharness: 2016-10-05 16:30:59.647905Z] Finished install step (success) 09:30:59 INFO - [mozharness: 2016-10-05 16:30:59.648150Z] Running run-tests step. 09:30:59 INFO - Running pre-action listener: _resource_record_pre_action 09:30:59 INFO - Running main action method: run_tests 09:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:30:59 INFO - Python 2.7.3 09:30:59 INFO - Return code: 0 09:30:59 INFO - grabbing minidump binary from tooltool 09:30:59 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')]} 09:30:59 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 0x1e98f60>, '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 0x1e99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:30:59 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 09:30:59 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 09:30:59 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 09:30:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:30:59 INFO - Return code: 0 09:30:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:30:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:30:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:30:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:30:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 09:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 09:30:59 INFO - Using env: {'DISPLAY': ':0', 09:30:59 INFO - 'HOME': '/home/cltbld', 09:30:59 INFO - 'LANG': 'en_US.UTF-8', 09:30:59 INFO - 'LANGUAGE': 'en_US:en', 09:30:59 INFO - 'LOGNAME': 'cltbld', 09:30:59 INFO - 'MAIL': '/var/mail/cltbld', 09:30:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:30:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:59 INFO - 'MOZ_NO_REMOTE': '1', 09:30:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:30:59 INFO - 'NO_EM_RESTART': '1', 09:30:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:59 INFO - 'PWD': '/builds/slave/test', 09:30:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:30:59 INFO - 'SHELL': '/bin/bash', 09:30:59 INFO - 'SHLVL': '1', 09:30:59 INFO - 'TERM': 'linux', 09:30:59 INFO - 'TMOUT': '86400', 09:30:59 INFO - 'USER': 'cltbld', 09:30:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486', 09:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:59 INFO - '_': '/tools/buildbot/bin/python'} 09:30:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 09:30:59 INFO - mozversion application_buildid: 20161005080902 09:30:59 INFO - mozversion application_changeset: 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 09:30:59 INFO - mozversion application_display_name: Nightly 09:30:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:30:59 INFO - mozversion application_name: Firefox 09:30:59 INFO - mozversion application_remotingname: firefox 09:30:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:30:59 INFO - mozversion application_vendor: Mozilla 09:30:59 INFO - mozversion application_version: 52.0a1 09:30:59 INFO - mozversion platform_buildid: 20161005080902 09:30:59 INFO - mozversion platform_changeset: 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 09:30:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:30:59 INFO - mozversion platform_version: 52.0a1 09:30:59 INFO - using testdate: 1475685059 09:30:59 INFO - actual date: 1475685059 09:30:59 INFO - starting webserver on 'localhost:55424' 09:30:59 INFO - SUITE-START | Running 2 tests 09:30:59 INFO - TEST-START | dromaeo_css 09:30:59 INFO - operating with platform_type : linux_ 09:30:59 INFO - Initialising browser for dromaeo_css test... 09:30:59 INFO - TEST-INFO | started process 1282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqOZlTV/profile http://localhost:55424/getInfo.html) 09:31:04 INFO - PROCESS | 1282 | __metrics Screen width/height:1600/1200 09:31:04 INFO - PROCESS | 1282 | colorDepth:24 09:31:04 INFO - PROCESS | 1282 | Browser inner width/height: 1024/697 09:31:04 INFO - PROCESS | 1282 | __metrics 09:31:04 INFO - PROCESS | 1282 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:31:04 INFO - PROCESS | 1282 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:31:05 INFO - PROCESS | 1282 | console.error: PushService: 09:31:05 INFO - PROCESS | 1282 | stateChangeProcessEnqueue: Error transitioning state 09:31:05 INFO - PROCESS | 1282 | UnknownError 09:31:06 INFO - TEST-INFO | 1282: exit 0 09:31:06 INFO - Browser initialized. 09:31:06 INFO - Running cycle 1/1 for dromaeo_css test... 09:31:06 INFO - TEST-INFO | started process 1366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqOZlTV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:18 INFO - PROCESS | 1366 | RSS: Main: 175460352 09:31:18 INFO - PROCESS | 1366 | 09:32:10 INFO - PROCESS | 1366 | 1475685130421 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] 09:34:23 INFO - PROCESS | 1366 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55424/tests/dromaeo/cssquery-ext.html) 09:34:24 INFO - PROCESS | 1366 | RSS: Main: 306810880 09:34:24 INFO - PROCESS | 1366 | 09:37:27 INFO - PROCESS | 1366 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-ext.html (next: http://localhost:55424/tests/dromaeo/cssquery-jquery.html) 09:37:27 INFO - PROCESS | 1366 | RSS: Main: 278335488 09:37:27 INFO - PROCESS | 1366 | 09:40:30 INFO - PROCESS | 1366 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55424/tests/dromaeo/cssquery-mootools.html) 09:40:30 INFO - PROCESS | 1366 | RSS: Main: 219627520 09:40:30 INFO - PROCESS | 1366 | 09:43:32 INFO - PROCESS | 1366 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55424/tests/dromaeo/cssquery-prototype.html) 09:43:33 INFO - PROCESS | 1366 | RSS: Main: 218550272 09:43:33 INFO - PROCESS | 1366 | 09:46:36 INFO - PROCESS | 1366 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55424/tests/dromaeo/cssquery-yui.html) 09:46:37 INFO - PROCESS | 1366 | RSS: Main: 219402240 09:46:37 INFO - PROCESS | 1366 | 09:49:40 INFO - PROCESS | 1366 | Cycle 1(1): loaded http://localhost:55424/tests/dromaeo/cssquery-yui.html (next: http://localhost:55424/tests/dromaeo/cssquery-dojo.html) 09:49:40 INFO - PROCESS | 1366 | RSS: Main: 291332096 09:49:40 INFO - PROCESS | 1366 | 09:49:40 INFO - PROCESS | 1366 | __start_tp_report 09:49:40 INFO - PROCESS | 1366 | _x_x_mozilla_page_load 09:49:40 INFO - PROCESS | 1366 | _x_x_mozilla_page_load_details 09:49:40 INFO - PROCESS | 1366 | |i|pagename|runs| 09:49:40 INFO - PROCESS | 1366 | |0;dojo.html;2537.3149249702583;2548.388386787169;2606.804489663276;2612.490564339954;2618.345413646587;4567.177907976571;4598.51715569865;4600.516945720701;4607.907841843161;4609;4615.69997950133;4637.35077089207;4645.396098507189;4667.15991121598;4729.266963620636;4197.811098500575;4212.831486740527;4260.914781704364;4297.806598703066;4307;4279.61483466488;4301.397804307399;4318.244307246235;4334.263175260214;4365.279728844736;4205.684573656958;4325.113351762881;4335.349697545377;4342.6742994275555;4438.400815889862;4235.322348424237;4237.4279472271155;4271.188474189925;4284.100338928829;4307.052448461333;4256;4256.08494173751;4271.786410679453;4306.720063195914;4316.719413238129;4596.954030459686;4602.148602508547;4626.259798432268;4634.328022436762;4677.836275730333;4746.976265118652;4779.689320194177;4929.1620424527555;4946.975265123651;4976.800927962877;4972.850814475535;5004.724740139291;5009.0983622948215;5014.097462456756;5039.874003149914;4668.6731928765;4674.719516829001;4677.415323084614;4677.812887484531;4734.384530011076;4950.777215025332;5004.724740139254;5063.341765570526;5111.897762044739;5173.094708426011;4878.048780487771;4907.288443175719;4910.288008238786;4965.751712414437;4969.627277954168;4964.528369804862;4976.8755781105765;4986.326845875833;4987.127252730757;5051.015052064886;4824.300476430898;4866.29438731389;4943.826966056171;4953.876153096201;5017.698938063728;4848.224284114595;4904.043711476228;4904.5340692634145;4916.434610019894;4976;4170.83316667336;4197.97901010493;4201.768902710319;4202.453681021448;4256.212600668886;3645.54430696163;3696.9260614787554;3711.1464363196615;3726.2920045191327;3735.9626403735615;4249.5113061997645;4270.017895883964;4299.484061912528;4299.935500967488;4362.956370436318;4997.750112494361;5001.424836143818;5043.36957880265;5047.646664733506;5099.464556221617;4298.398224248608;4303.440552728125;4306.5262821089655;4314.007778211029;4364.978175109104;4442.044960333544;4462.44219472566;4472.709273897186;4479.10417916418;4512.638988880882;4659.277811939155;4670.416197975253;4688.507706690748;4698.694584851974;4718.646101542329;4965.950340496694;4976.427710813303;4977.726225057657;4986.227134794112;5043.823466178666;4545.363649089196;4581.816727330869;4620.052889157648;4636.652251081115;4647.721136731807;4874.902501950012;4898.853034408973;4902.362692849907;4941.703497790144;4960.72716000609;4962.950370496249;4974.353334066548;4976.054549635558;4978.925316120333;5038.445770965264;4684.414448193976;4759.643026773075;4770.379850619536;4851.102546028996;4908.484609116134;4846.151923413459;4881.658283920092;4889.364382630235;4927.778249978688;4941.530554597308;4779.498152693917;4802.351682522814;4803.615710743202;4816.927746083741;4879.804807807648;4751.477337492942;4779.976100119477;4806.255030470283;4825.734584597881;4860.586850117779;4758.762061896822;4791.089692958327;4831.661783675109;4836.588889944394;4844.031193761191 09:49:40 INFO - PROCESS | 1366 | |1;ext.html;561.719140429785;575.2808988764042;577.6938222741949;580.396387756733;580.509469498274;28065.43869122616;38702.61297387025;39793.80103099488;39804.40293395598;43356.349654755206;40028.59971400285;40482.39276410856;40500.59499405005;40513.189736205255;40559.79720101396;7562.88655670164;7689.423293253;7719.112302085247;7725.49784264021;7726.42051846111;7261.128664560234;7445.627718614075;9658.613655453773;9945.850812237823;9946.055124763172;9766.072223138826;9841.45871977041;9856.26078044146;9859.260555458333;9863.654772082979;9939.40363578184;10032.498375081217;10033.04686054831;10034.698959031204;10042.497875106215;9414.293927955363;9549.09283618055;9559;9562.043795620451;9569.569369378394;36973;37106.443403348974;37198.814005929795;37280.62719372799;37280.62719372826;2691.3540750220004;3127.53087036944;3138.4978403455566;3142.230153612357;3172.6510083890753;27632.309192270153;27972.300692482648;28999.39005489516;29121.708782912112;29170.311789201114;3284.655111213312;3402.6767457091537;3421.6578342165585;3465.358908601917;3479.5302634144573;205520;259419;262317;262583;262895;52639.473605263454;53085.734571326895;53099.73450132802;53101;53120.734396327774;32722.83638581792;33119.3376132476;33333;35415.645843541235;35426.29147417037;13092.149010314299;13228.338583071001;13232.272225027717;13251.602451926265;13255.536056237985;9354.71935841926;9590.42457452555;9810.215182785503;9919.900800991898;9928.851067233998;17048.659026819394;17298.65402691964;17472.213750381263;18343.35798247055;18407.355742548945;6544.247411547638;6622.086606505276;6626.337366263431;6635;6920.9653951729915;734.181387752652;829.4442723375353;844.7254642241296;857.8756080368312;927.893292271384;26085.347866303495;27603.447931041268;28097.157085287476;28299.43401131966;28366.290842728686;873.3144481582054;909.5906841921029;919.4299534288783;939.6429356844492;970.2432102959702;14285.285735713172;14792.63018424548;14833.258337083103;14976.850231497763;15106.244687765568;369783;373544;373568;373748;374072;31903.52144717831;48357.758211209424;48408.75795620999;48539.271910921365;48551.271730923356;1063.1229235880276;1071.4374953149659;1114.0864491117206;1147.7474955509942;1161.703765539799;25384.492310154063;28884;29325.413491729618;29851.552226717053;29899;41207.1758564833;41765.791171045166;41792.3731144027;41816.1636767269;41846.16307673891;236438;236615;236632;236695;236823;24788;25088;25562.36094097588;25563;26876.865615672577;39520.60479395284;39885.2022959545;40130.39804402995;40862.387064194656;40888;31210;31542;31594.628913084372;31699.683003169674;32489.512657309686;34199;34511.4823277646;34835.303293934485;34934.47598285977;35229;33765.97404155759;34245.82877085599;34565.48151777776;34621.65378346184;34882.825585871906;30095.24761880883;31404;31716.682833171373;31993.360132796748;32014.51978220375;24627.384315392257;24770;24829.92857499582;24864.87567562223;25205 09:49:40 INFO - PROCESS | 1366 | |2;jquery.html;334.049628806047;342.52218155672836;355.5537800060923;358.29416050380746;375.36375842946217;11999.940000300008;15574.766378504331;15863.444779432708;16719.49841504754;16901.323947042103;13960.301984900765;14855;16701.665966680688;17075.060871652055;17219.225134868928;4117.876463706094;4830.686005409637;4920.557149856512;5122.282880396729;5143.099957507421;5058.924116138261;5146.74266286686;5148.124818780816;5151.4333423323405;5152.510511501401;5115.079285728568;5119.232115182734;5123.948760512403;6570.178727659043;6931.896021559681;6831.69257383419;6879.140107486539;7032.929670703279;7061.329173728487;7064.222935477068;6795.490338224653;6904.758333458355;6910.861782764367;6915.619640919747;6917.7232910683515;22440.438989025242;22814.771852281596;22847.42881427961;22927.426814329774;23025.309240722807;1792.7310903364469;1918.2518817661123;1953.8925359105244;1986.4934441717414;2078.158345869925;13684.384202710902;13884.23636699981;13896.374663140183;14737.778933316009;15343.923280383638;1837;1846.2153584726573;1850.4448665400325;1909.3794516782102;1921.6541022615922;65889.67055164694;82652;83509;83862.71924567534;86865.56567217123;15814.9209253953;15926.203689815462;16175.838241617434;16195.433159839584;16707.415240466526;28307;28332.433351332857;28415.28961775972;28671.283217919303;28717.28206794847;8058.677652893936;8322.791930201793;8383.371247156487;8459.407841451162;8569.95715021421;6673.432758215509;6892.760402610765;6895.793126206222;6924.307569243036;7070.717171313193;8174.3460523158;8199.631016604148;8253.422260441832;8256.876146857801;8372.665093396317;3190.920226994297;3195.7762956592815;3284.8850290240207;3298.752593555493;3366.7342677603174;752.6048824367251;769.8768197088439;776.2703059124404;808.1837344282317;886.9512176830336;15632.92183539075;16291.348346066261;16519.174041297887;16982.830171698373;17321;844.6959094725894;844.7930257087053;844.936629752771;888.8711136885115;906.207068814787;9139.314551408672;9310.767230819149;9539.761505962268;9547.42715437076;9687.612495500241;349734;355339;355501;356876;358805;46557;49868;65832.01251981224;70746;72310.63844680742;856.3472498078644;862.4825104937113;890.9020007799137;898.6764764684708;903.051795614602;11024.50389732448;14085.718285634024;15156.469523566622;15475.071495710294;15736.68526629438;37464.250714985;37693.81153094217;37870.24259514849;38078;39481;48626.756866215444;48683.269750953055;48899;49161.10066792008;49466.25800613066;7215.242399547972;7259.274072592699;7277.417806575567;7316.817079573053;7832;7938;9843.557039933363;11822.527098915947;11833.52665893389;12258.448369823558;9707.271954603291;9870;10051;10129.139023182817;10416.791664166825;10168.389896606228;10213.846792297973;10215.94892025535;10347.793044139225;10366.222533309881;10213.846792297973;10287.279890407899;10380.792384152426;10659.4137322448;10827.350358978487;7187.425005999612;7335.889961650686;7427.777166684792;7430.108386993596;7528.661210245662;8937.195652391316;9879.30844840883;9975.950120249352;10098.727786248035;10237.9488102559 09:49:40 INFO - PROCESS | 1366 | |3;mootools.html;1250.2311078686605;1292.302156835309;1312.8250216056629;1624.301550333356;1628.4463282483969;6833.077534532837;7044.647767611625;7412.629368531579;8075.434719569633;8075.798105047376;7113.253108423606;7383.5200711953685;7387.5936823474685;7553.924460755391;7557.84884302315;2070.9378718638427;2095.182878677317;2096.695979083032;2102.7581828089815;2106.199644135234;1827.8994655293955;1891.1206289075576;2045.4988527810708;2064.194963964055;2075.8650687705326;1944.9222031118738;1999.9300024499146;2002.269171752307;2011.859169858103;2014.1641218894142;2012.154894944127;2030.4416285521452;2034.837213022962;2039.479932617173;2041.4590133614604;1951.677973134431;1955.0908827395187;1960.8235258826774;1964.9705254421194;1966.2724791826972;7502.512336698152;7559.69761209551;7562.470627056108;7568.659410326549;7569.432292578079;4335.913281734348;4440.866773996753;4528.1622899763315;4533.478649955265;4535.229011068126;2657.760801527872;2800.131959092688;2812.592174134739;2815.9296017599518;2826.462972035307;832.508819796317;843.8101427178897;887.352232870002;891.9821603567892;894.8120894612074;10556.313839600478;10631.574737010511;10637.521311540999;10650.786984260349;10660.946695266473;3805.9429108563395;3939.940900886489;3961.2869683457257;4116.135611521614;4125.525564560054;9175.44947303164;9186.40288381253;9190.678326258549;9237.168654821098;9271.768205794775;4404.295312749945;4408.096340250241;4411.713238639478;4413.801378937956;4415.5363686812425;4010.6991975601945;4024.8188831502653;4045.211183819186;4051.716379853441;4053.5338436079637;3534.4874993125854;3556.2354093869944;3633.8364773585254;3633.8909832705062;3668.284684486553;1042.8592140061146;1080.6487891435315;1159.2986243322837;1164.394514852272;1170.104869774623;674.6120980436269;686.5262968551683;697.2817997462622;738.5384134915678;766.4673052228648;4818.951810481921;4867.5132486751045;4927.77824997876;4973.179425394842;5120.743962801845;766.2490759056157;772.2162005564356;781.9648115834801;829.1169904052165;867.6572753762229;3297.934041319208;3314.950275745866;3362.9495557566656;3395.168183794986;3445;9518.286128540387;9954.054364835329;9955.900440995641;9962.750931226632;9975.600975961026;9912.702618921443;9942.900570994341;9943.651972180938;9943.950280248697;9945.999999999854;7291.817704557322;7327.890081648886;7337.266273372727;7475.775726728207;7489.176190619028;4819.1566475867285;4864.73243971585;4870.9269360960325;4895.143349913679;5014.147594908802;8753.387262891536;8857.734267971971;8864.113588641085;8960.417572857743;9012.594433250388;8772.078931712078;9186.356955013085;9298.628054877729;9308.208802251613;9310.720678379388;6109.908351374644;6199.318075011835;6261.5616906816085;6261.592996455216;6265.718042687999;7297.927020729725;7317.67070481819;7327.157376901724;7330.157031941182;7336.559806411632;6615.338466153346;6685.197776266879;6700.698468569024;6705.631190284386;6818.761343353157;6332.588381755171;6545.934540654723;6547.148870646785;6577.835554111186;6724.058631791455;5844.211031510692;6083.939160608337;6097.908531372122;6109.572329936862;6113.327533971348;4317.201317756225;4373.540778218241;4415.2494076006515;4444.733316000921;4492.326151077234;4345.2395830728865;4377.146456440963;4497.235469970178;4554.476235232991;4568.4974652787505 09:49:40 INFO - PROCESS | 1366 | |4;prototype.html;281.3781542790433;285.9456703226387;288.8454676747939;291.53791240883197;296.17367544550706;4816.855494335166;4863.61091112711;4877.5122487751205;4882.462024462301;4924.458309585947;4505.57197066279;4777.474477807438;4805.81335492351;4830.468648448667;4840;3647.452882067691;3662.633736626343;3732.64539868712;3800.5439347278366;3809.961900381002;3762.3980163173896;3787.791671458069;3795.4496597993275;3801.1257410795533;3805.9429108563395;3549.822508874559;3737.962620373802;3742.3263812513737;3768.1144930941205;3786.8295926683363;3642.508261384719;3654.1778099927437;3704.944090934098;3737.9439308410124;3746.344389731786;3312.337532493487;3313.2710803623163;3313.7349012079217;3325.5676762021026;3328.9667103328898;4691.437027556715;4696.882577935545;4706.576408123286;4707.176244157259;4722.83470078549;4176.387424877489;4254.170436764832;4285.185814695229;4303.677224208165;4347.217500849846;4990.476000019982;4994.800207991676;4996.12567800637;4999.475055119233;5003.3495645565845;3596.6692323840084;3597.4244120940784;3605.873794417209;3611.5846677632144;3615.493830863681;5076.213186956028;5223.1642937130255;5231.189165679288;5302.840914772563;5309.734513274321;3688.870889518854;3694.113412780913;3698.223373091681;3714.3285521515427;3721.925561488755;3748.8687895923513;3755.5493340798735;3758.793266370376;3761.1161377076364;3763.8682646107254;4279.272523670983;4281.571842815693;4296.656267498593;4300.548442413564;4333.133373325348;4916.237983112624;5030.773615187325;5032.245163225472;5032.572231360376;5119.846404607868;1278.8721127887136;1290.9289989050692;1293.359786905469;1294.9417276222594;1298.1756584568866;839.8320335932838;842.2461896602506;843.1947490146895;847.9576021198916;866.8136350684633;4317.977415808947;4331.198728235224;4356.651467882625;4453.888652783707;4475.194464996332;5156.793728250828;5160.7419629018395;5184.7407629618365;5197;5204.4014938281825;4275.935860962088;4403.229434848953;4403.713758605681;4419.513853476115;4420.961074147637;2728.140635699748;2728.508868403667;2744.2041807875894;2757.648752111451;2762.1575419497244;4854.393200849894;4860.975695121501;4862.82980095695;4891.51084891508;4904.901901962012;5107.8723031923755;5252.868678282997;5307.150855863043;5322.520973112361;5354.3842458117815;4781.545753153445;4815;4824.094482679392;4826.334914454507;4827.879303017382;5130.794263348035;5162.612804039637;5169;5189.365349914765;5197.298364720866;4998.150314446625;5051.2825639281355;5056.62075344358;5089.236614507853;5158.329417175743;4837.588804951478;4866.464688884291;4866.683665561727;4874.268859671078;4877.292792545132;3693.390590552529;3705.351563476327;3710.7959062251834;3728.086618778417;3729.086373838427;5001.174806156943;5160.845174644766;5170.767315470737;5201.921971170511;5284.762185701729;5050.545450909436;5056.721880296619;5067.949320506747;5069.645124841226;5088.414832294334;5029.572486338556;5039.143345631325;5060.620453465931;5086.313347698014;5090.643654944267;4751.762411879461;4989.276554899447;4992.950070499393;5016.548510633915;5027.773750181177;4856.805727770849;4964.578010869117;5028.874278143076;5128.512731307879;5158.200478925773;4980.950190498049;4994.850154495226;5008.398992120969;5014.749262536786;5033.798648054037 09:49:40 INFO - PROCESS | 1366 | |5;yui.html;572.5162237908967;582.3972188784608;587.3509771702269;611.3794498583939;644.1818890009685;10914.454277286133;11425.828612570807;11444.885551144485;11482.425878706052;11583.18917675763;11301.773964520704;11402.543898244081;11406.71483212918;11409.20135590509;11411.372374519418;610.8900397928371;614.7602435050334;621.0404924391826;737.4985010193067;761.6839011810092;729.1905984357359;737.0344848248784;738.3059923671732;749.3518106837573;752.8720117580025;793.9563324017206;796.1839114907237;796.3151689546985;797.0117054852;797.0594698256056;637.5186734015834;654.2770238886058;767.8464307138539;793.1830214878655;793.7499687598388;568.6957477749385;576.622312385384;580.4717706886713;580.9796657116981;581.0818906128308;12763.489460421571;12776;12795.552155674506;12803.48786048557;12805.55180568685;12037.939810300892;12354.629361119181;12775.744485110246;12815.487380504768;12995;9713.61145554184;9719.805603887882;9793.21654267657;10410.635627753069;11180.44097795107;4108.116754897682;4115.773632450214;4121.155163191568;4122.6083522065655;4313.762743049131;58449.12326315109;58658.413415865725;59036;59566.702166489325;59733.40266597322;9368.2973776967;10058.14505767018;10080;10329.431881246604;10464.21518386124;16752.24614892333;16883;16884;16890.071046092336;16920.153992300337;6215.12988181655;6305.779297724557;6329.873402531924;6434.613923164625;6439.967800160969;3318.1538707629884;3442.3631628148373;3450.413429716954;3472.2361080562237;3536.929261414809;2620.7772339350986;2734.412101398169;2734.644496215479;2740.10946442407;2741.9588706169425;517.1338008835186;533.4931814775979;543.5760107116455;544.276112770015;550.6640949021094;515.7885267040496;523.9337947277348;524.5410266017235;556.4769117029979;579.8927198468213;7264.491485595958;7333.267070867664;7881.408894332948;8443.451175673561;8509.957450212709;484.1962342511414;495.07174048658766;545.939946605873;550.8512701570553;572.718926027946;3958.44581758554;3964.1278918637854;4046.858359957387;4054.878353649395;4130.648894843972;74056.25943740601;74966;89084;98773;101358;71894;72310.63844680849;72380.63809680918;73742;74856.25143748493;63914;65713;66861.99999999903;66953;69214.30785692179;8543.273821724973;8990.730278091667;9189.310801690033;9201.815963680823;9305.674301399418;40740.185196295315;41155.58844411517;41619.37570936499;41689.37465938074;43198.78400608103;53204;57344.71327643335;59390.40609594022;59943.40056599553;62955;10992.230543861853;11178.441077945907;11255.268407553483;11536.134789890959;11945.16383853122;12028.939855301018;12127.784958377186;12393.318367489876;12460.391797365592;13378.598642040753;11923.642290731292;12005.739795918493;12157.209781364183;12364.505419783109;12929.806052909402;11747.706307342385;11906.107041971714;12689.682757931125;12847.229166249681;12911.935440323114;11747.647570572555;11983;12849.807252891402;12985.091043626855;13050.34748262602;8964.238039766693;9175.816483670156;9314.115159059878;9407.670731524637;9527.523623818919;9768.462734549385;10557.313774604627;10821.945890270814;10913.618023369145;10932.234743568191 09:49:40 INFO - PROCESS | 1366 | __end_tp_report 09:49:40 INFO - PROCESS | 1366 | __start_cc_report 09:49:40 INFO - PROCESS | 1366 | _x_x_mozilla_cycle_collect,1282 09:49:40 INFO - PROCESS | 1366 | __end_cc_report 09:49:40 INFO - PROCESS | 1366 | __startTimestamp1475686180657__endTimestamp 09:49:40 INFO - PROCESS | 1366 | 09:49:40 INFO - PROCESS | 1366 | ------- Summary: start ------- 09:49:40 INFO - PROCESS | 1366 | Number of tests: 6 09:49:40 INFO - PROCESS | 1366 | 09:49:40 INFO - PROCESS | 1366 | [#0] dojo.html Cycles:165 Average:4595.40 Median:4698.69 stddev:479.38 (10.2%) stddev-sans-first:452.85 09:49:40 INFO - PROCESS | 1366 | Values: 2537.3 2548.4 2606.8 2612.5 2618.3 4567.2 4598.5 4600.5 4607.9 4609.0 4615.7 4637.4 4645.4 4667.2 4729.3 4197.8 4212.8 4260.9 4297.8 4307.0 4279.6 4301.4 4318.2 4334.3 4365.3 4205.7 4325.1 4335.3 4342.7 4438.4 4235.3 4237.4 4271.2 4284.1 4307.1 4256.0 4256.1 4271.8 4306.7 4316.7 4597.0 4602.1 4626.3 4634.3 4677.8 4747.0 4779.7 4929.2 4947.0 4976.8 4972.9 5004.7 5009.1 5014.1 5039.9 4668.7 4674.7 4677.4 4677.8 4734.4 4950.8 5004.7 5063.3 5111.9 5173.1 4878.0 4907.3 4910.3 4965.8 4969.6 4964.5 4976.9 4986.3 4987.1 5051.0 4824.3 4866.3 4943.8 4953.9 5017.7 4848.2 4904.0 4904.5 4916.4 4976.0 4170.8 4198.0 4201.8 4202.5 4256.2 3645.5 3696.9 3711.1 3726.3 3736.0 4249.5 4270.0 4299.5 4299.9 4363.0 4997.8 5001.4 5043.4 5047.6 5099.5 4298.4 4303.4 4306.5 4314.0 4365.0 4442.0 4462.4 4472.7 4479.1 4512.6 4659.3 4670.4 4688.5 4698.7 4718.6 4966.0 4976.4 4977.7 4986.2 5043.8 4545.4 4581.8 4620.1 4636.7 4647.7 4874.9 4898.9 4902.4 4941.7 4960.7 4963.0 4974.4 4976.1 4978.9 5038.4 4684.4 4759.6 4770.4 4851.1 4908.5 4846.2 4881.7 4889.4 4927.8 4941.5 4779.5 4802.4 4803.6 4816.9 4879.8 4751.5 4780.0 4806.3 4825.7 4860.6 4758.8 4791.1 4831.7 4836.6 4844.0 09:49:40 INFO - PROCESS | 1366 | 09:49:40 INFO - PROCESS | 1366 | [#1] ext.html Cycles:180 Average:43761.12 Median:34859.06 stddev:77077.48 (221.1%) stddev-sans-first:77225.46 09:49:40 INFO - PROCESS | 1366 | Values: 561.7 575.3 577.7 580.4 580.5 28065.4 38702.6 39793.8 39804.4 43356.3 40028.6 40482.4 40500.6 40513.2 40559.8 7562.9 7689.4 7719.1 7725.5 7726.4 7261.1 7445.6 9658.6 9945.9 9946.1 9766.1 9841.5 9856.3 9859.3 9863.7 9939.4 10032.5 10033.0 10034.7 10042.5 9414.3 9549.1 9559.0 9562.0 9569.6 36973.0 37106.4 37198.8 37280.6 37280.6 2691.4 3127.5 3138.5 3142.2 3172.7 27632.3 27972.3 28999.4 29121.7 29170.3 3284.7 3402.7 3421.7 3465.4 3479.5 205520.0 259419.0 262317.0 262583.0 262895.0 52639.5 53085.7 53099.7 53101.0 53120.7 32722.8 33119.3 33333.0 35415.6 35426.3 13092.1 13228.3 13232.3 13251.6 13255.5 9354.7 9590.4 9810.2 9919.9 9928.9 17048.7 17298.7 17472.2 18343.4 18407.4 6544.2 6622.1 6626.3 6635.0 6921.0 734.2 829.4 844.7 857.9 927.9 26085.3 27603.4 28097.2 28299.4 28366.3 873.3 909.6 919.4 939.6 970.2 14285.3 14792.6 14833.3 14976.9 15106.2 369783.0 373544.0 373568.0 373748.0 374072.0 31903.5 48357.8 48408.8 48539.3 48551.3 1063.1 1071.4 1114.1 1147.7 1161.7 25384.5 28884.0 29325.4 29851.6 29899.0 41207.2 41765.8 41792.4 41816.2 41846.2 236438.0 236615.0 236632.0 236695.0 236823.0 24788.0 25088.0 25562.4 25563.0 26876.9 39520.6 39885.2 40130.4 40862.4 40888.0 31210.0 31542.0 31594.6 31699.7 32489.5 34199.0 34511.5 34835.3 34934.5 35229.0 33766.0 34245.8 34565.5 34621.7 34882.8 30095.2 31404.0 31716.7 31993.4 32014.5 24627.4 24770.0 24829.9 24864.9 25205.0 09:49:40 INFO - PROCESS | 1366 | 09:49:40 INFO - PROCESS | 1366 | [#2] jquery.html Cycles:180 Average:24071.41 Median:26728.72 stddev:58730.85 (219.7%) stddev-sans-first:58868.57 09:49:40 INFO - PROCESS | 1366 | Values: 334.0 342.5 355.6 358.3 375.4 11999.9 15574.8 15863.4 16719.5 16901.3 13960.3 14855.0 16701.7 17075.1 17219.2 4117.9 4830.7 4920.6 5122.3 5143.1 5058.9 5146.7 5148.1 5151.4 5152.5 5115.1 5119.2 5123.9 6570.2 6931.9 6831.7 6879.1 7032.9 7061.3 7064.2 6795.5 6904.8 6910.9 6915.6 6917.7 22440.4 22814.8 22847.4 22927.4 23025.3 1792.7 1918.3 1953.9 1986.5 2078.2 13684.4 13884.2 13896.4 14737.8 15343.9 1837.0 1846.2 1850.4 1909.4 1921.7 65889.7 82652.0 83509.0 83862.7 86865.6 15814.9 15926.2 16175.8 16195.4 16707.4 28307.0 28332.4 28415.3 28671.3 28717.3 8058.7 8322.8 8383.4 8459.4 8570.0 6673.4 6892.8 6895.8 6924.3 7070.7 8174.3 8199.6 8253.4 8256.9 8372.7 3190.9 3195.8 3284.9 3298.8 3366.7 752.6 769.9 776.3 808.2 887.0 15632.9 16291.3 16519.2 16982.8 17321.0 844.7 844.8 844.9 888.9 906.2 9139.3 9310.8 9539.8 9547.4 9687.6 349734.0 355339.0 355501.0 356876.0 358805.0 46557.0 49868.0 65832.0 70746.0 72310.6 856.3 862.5 890.9 898.7 903.1 11024.5 14085.7 15156.5 15475.1 15736.7 37464.3 37693.8 37870.2 38078.0 39481.0 48626.8 48683.3 48899.0 49161.1 49466.3 7215.2 7259.3 7277.4 7316.8 7832.0 7938.0 9843.6 11822.5 11833.5 12258.4 9707.3 9870.0 10051.0 10129.1 10416.8 10168.4 10213.8 10215.9 10347.8 10366.2 10213.8 10287.3 10380.8 10659.4 10827.4 7187.4 7335.9 7427.8 7430.1 7528.7 8937.2 9879.3 9976.0 10098.7 10237.9 09:49:40 INFO - PROCESS | 1366 | 09:49:40 INFO - PROCESS | 1366 | [#3] mootools.html Cycles:180 Average:5020.83 Median:4911.46 stddev:2925.13 (59.6%) stddev-sans-first:2919.61 09:49:40 INFO - PROCESS | 1366 | Values: 1250.2 1292.3 1312.8 1624.3 1628.4 6833.1 7044.6 7412.6 8075.4 8075.8 7113.3 7383.5 7387.6 7553.9 7557.8 2070.9 2095.2 2096.7 2102.8 2106.2 1827.9 1891.1 2045.5 2064.2 2075.9 1944.9 1999.9 2002.3 2011.9 2014.2 2012.2 2030.4 2034.8 2039.5 2041.5 1951.7 1955.1 1960.8 1965.0 1966.3 7502.5 7559.7 7562.5 7568.7 7569.4 4335.9 4440.9 4528.2 4533.5 4535.2 2657.8 2800.1 2812.6 2815.9 2826.5 832.5 843.8 887.4 892.0 894.8 10556.3 10631.6 10637.5 10650.8 10660.9 3805.9 3939.9 3961.3 4116.1 4125.5 9175.4 9186.4 9190.7 9237.2 9271.8 4404.3 4408.1 4411.7 4413.8 4415.5 4010.7 4024.8 4045.2 4051.7 4053.5 3534.5 3556.2 3633.8 3633.9 3668.3 1042.9 1080.6 1159.3 1164.4 1170.1 674.6 686.5 697.3 738.5 766.5 4819.0 4867.5 4927.8 4973.2 5120.7 766.2 772.2 782.0 829.1 867.7 3297.9 3315.0 3362.9 3395.2 3445.0 9518.3 9954.1 9955.9 9962.8 9975.6 9912.7 9942.9 9943.7 9944.0 9946.0 7291.8 7327.9 7337.3 7475.8 7489.2 4819.2 4864.7 4870.9 4895.1 5014.1 8753.4 8857.7 8864.1 8960.4 9012.6 8772.1 9186.4 9298.6 9308.2 9310.7 6109.9 6199.3 6261.6 6261.6 6265.7 7297.9 7317.7 7327.2 7330.2 7336.6 6615.3 6685.2 6700.7 6705.6 6818.8 6332.6 6545.9 6547.1 6577.8 6724.1 5844.2 6083.9 6097.9 6109.6 6113.3 4317.2 4373.5 4415.2 4444.7 4492.3 4345.2 4377.1 4497.2 4554.5 4568.5 09:49:40 INFO - PROCESS | 1366 | 09:49:40 INFO - PROCESS | 1366 | [#4] prototype.html Cycles:180 Average:4184.92 Median:4815.93 stddev:1214.05 (25.2%) stddev-sans-first:1181.57 09:49:40 INFO - PROCESS | 1366 | Values: 281.4 285.9 288.8 291.5 296.2 4816.9 4863.6 4877.5 4882.5 4924.5 4505.6 4777.5 4805.8 4830.5 4840.0 3647.5 3662.6 3732.6 3800.5 3810.0 3762.4 3787.8 3795.4 3801.1 3805.9 3549.8 3738.0 3742.3 3768.1 3786.8 3642.5 3654.2 3704.9 3737.9 3746.3 3312.3 3313.3 3313.7 3325.6 3329.0 4691.4 4696.9 4706.6 4707.2 4722.8 4176.4 4254.2 4285.2 4303.7 4347.2 4990.5 4994.8 4996.1 4999.5 5003.3 3596.7 3597.4 3605.9 3611.6 3615.5 5076.2 5223.2 5231.2 5302.8 5309.7 3688.9 3694.1 3698.2 3714.3 3721.9 3748.9 3755.5 3758.8 3761.1 3763.9 4279.3 4281.6 4296.7 4300.5 4333.1 4916.2 5030.8 5032.2 5032.6 5119.8 1278.9 1290.9 1293.4 1294.9 1298.2 839.8 842.2 843.2 848.0 866.8 4318.0 4331.2 4356.7 4453.9 4475.2 5156.8 5160.7 5184.7 5197.0 5204.4 4275.9 4403.2 4403.7 4419.5 4421.0 2728.1 2728.5 2744.2 2757.6 2762.2 4854.4 4861.0 4862.8 4891.5 4904.9 5107.9 5252.9 5307.2 5322.5 5354.4 4781.5 4815.0 4824.1 4826.3 4827.9 5130.8 5162.6 5169.0 5189.4 5197.3 4998.2 5051.3 5056.6 5089.2 5158.3 4837.6 4866.5 4866.7 4874.3 4877.3 3693.4 3705.4 3710.8 3728.1 3729.1 5001.2 5160.8 5170.8 5201.9 5284.8 5050.5 5056.7 5067.9 5069.6 5088.4 5029.6 5039.1 5060.6 5086.3 5090.6 4751.8 4989.3 4993.0 5016.5 5027.8 4856.8 4964.6 5028.9 5128.5 5158.2 4981.0 4994.9 5008.4 5014.7 5033.8 09:49:40 INFO - PROCESS | 1366 | 09:49:40 INFO - PROCESS | 1366 | [#5] yui.html Cycles:180 Average:16557.85 Median:524.24 stddev:22816.94 (4352.4%) stddev-sans-first:22849.37 09:49:40 INFO - PROCESS | 1366 | Values: 572.5 582.4 587.4 611.4 644.2 10914.5 11425.8 11444.9 11482.4 11583.2 11301.8 11402.5 11406.7 11409.2 11411.4 610.9 614.8 621.0 737.5 761.7 729.2 737.0 738.3 749.4 752.9 794.0 796.2 796.3 797.0 797.1 637.5 654.3 767.8 793.2 793.7 568.7 576.6 580.5 581.0 581.1 12763.5 12776.0 12795.6 12803.5 12805.6 12037.9 12354.6 12775.7 12815.5 12995.0 9713.6 9719.8 9793.2 10410.6 11180.4 4108.1 4115.8 4121.2 4122.6 4313.8 58449.1 58658.4 59036.0 59566.7 59733.4 9368.3 10058.1 10080.0 10329.4 10464.2 16752.2 16883.0 16884.0 16890.1 16920.2 6215.1 6305.8 6329.9 6434.6 6440.0 3318.2 3442.4 3450.4 3472.2 3536.9 2620.8 2734.4 2734.6 2740.1 2742.0 517.1 533.5 543.6 544.3 550.7 515.8 523.9 524.5 556.5 579.9 7264.5 7333.3 7881.4 8443.5 8510.0 484.2 495.1 545.9 550.9 572.7 3958.4 3964.1 4046.9 4054.9 4130.6 74056.3 74966.0 89084.0 98773.0 101358.0 71894.0 72310.6 72380.6 73742.0 74856.3 63914.0 65713.0 66862.0 66953.0 69214.3 8543.3 8990.7 9189.3 9201.8 9305.7 40740.2 41155.6 41619.4 41689.4 43198.8 53204.0 57344.7 59390.4 59943.4 62955.0 10992.2 11178.4 11255.3 11536.1 11945.2 12028.9 12127.8 12393.3 12460.4 13378.6 11923.6 12005.7 12157.2 12364.5 12929.8 11747.7 11906.1 12689.7 12847.2 12911.9 11747.6 11983.0 12849.8 12985.1 13050.3 8964.2 9175.8 9314.1 9407.7 9527.5 9768.5 10557.3 10821.9 10913.6 10932.2 09:49:40 INFO - PROCESS | 1366 | -------- Summary: end -------- 09:49:40 INFO - PROCESS | 1366 | 09:49:41 INFO - TEST-INFO | 1366: exit 0 09:49:41 INFO - TEST-OK | dromaeo_css | took 1121732ms 09:49:41 INFO - TEST-START | kraken 09:49:41 INFO - operating with platform_type : linux_ 09:49:41 INFO - Initialising browser for kraken test... 09:49:41 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI9S_R4/profile http://localhost:55424/getInfo.html) 09:49:46 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 09:49:46 INFO - PROCESS | 1675 | colorDepth:24 09:49:46 INFO - PROCESS | 1675 | Browser inner width/height: 1024/697 09:49:46 INFO - PROCESS | 1675 | __metrics 09:49:46 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:49:46 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:49:47 INFO - PROCESS | 1675 | console.error: PushService: 09:49:47 INFO - PROCESS | 1675 | stateChangeProcessEnqueue: Error transitioning state 09:49:47 INFO - PROCESS | 1675 | UnknownError 09:49:47 INFO - TEST-INFO | 1675: exit 0 09:49:47 INFO - Browser initialized. 09:49:47 INFO - Running cycle 1/1 for kraken test... 09:49:47 INFO - TEST-INFO | started process 1758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI9S_R4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:00 INFO - PROCESS | 1758 | RSS: Main: 174919680 09:50:00 INFO - PROCESS | 1758 | 09:50:02 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55424/tests/kraken/driver.html?testName=audio-beat-detection) 09:50:03 INFO - PROCESS | 1758 | RSS: Main: 237846528 09:50:03 INFO - PROCESS | 1758 | 09:50:06 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55424/tests/kraken/driver.html?testName=audio-dft) 09:50:07 INFO - PROCESS | 1758 | RSS: Main: 218988544 09:50:07 INFO - PROCESS | 1758 | 09:50:10 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55424/tests/kraken/driver.html?testName=audio-fft) 09:50:11 INFO - PROCESS | 1758 | RSS: Main: 301178880 09:50:11 INFO - PROCESS | 1758 | 09:50:13 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55424/tests/kraken/driver.html?testName=audio-oscillator) 09:50:13 INFO - PROCESS | 1758 | RSS: Main: 211558400 09:50:13 INFO - PROCESS | 1758 | 09:50:16 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:50:16 INFO - PROCESS | 1758 | RSS: Main: 214470656 09:50:16 INFO - PROCESS | 1758 | 09:50:19 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55424/tests/kraken/driver.html?testName=imaging-darkroom) 09:50:20 INFO - PROCESS | 1758 | RSS: Main: 251158528 09:50:20 INFO - PROCESS | 1758 | 09:50:24 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55424/tests/kraken/driver.html?testName=imaging-desaturate) 09:50:24 INFO - PROCESS | 1758 | RSS: Main: 244183040 09:50:24 INFO - PROCESS | 1758 | 09:50:27 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55424/tests/kraken/driver.html?testName=json-parse-financial) 09:50:28 INFO - PROCESS | 1758 | RSS: Main: 246726656 09:50:28 INFO - PROCESS | 1758 | 09:50:29 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:50:30 INFO - PROCESS | 1758 | RSS: Main: 210653184 09:50:30 INFO - PROCESS | 1758 | 09:50:32 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:50:33 INFO - PROCESS | 1758 | RSS: Main: 218161152 09:50:33 INFO - PROCESS | 1758 | 09:50:35 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:50:35 INFO - PROCESS | 1758 | RSS: Main: 227549184 09:50:35 INFO - PROCESS | 1758 | 09:50:38 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:50:39 INFO - PROCESS | 1758 | RSS: Main: 236376064 09:50:39 INFO - PROCESS | 1758 | 09:50:42 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:50:43 INFO - PROCESS | 1758 | RSS: Main: 233283584 09:50:43 INFO - PROCESS | 1758 | 09:50:44 INFO - PROCESS | 1758 | Cycle 1(1): loaded http://localhost:55424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55424/tests/kraken/driver.html?testName=ai-astar) 09:50:45 INFO - PROCESS | 1758 | RSS: Main: 282312704 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | __start_tp_report 09:50:45 INFO - PROCESS | 1758 | _x_x_mozilla_page_load 09:50:45 INFO - PROCESS | 1758 | _x_x_mozilla_page_load_details 09:50:45 INFO - PROCESS | 1758 | |i|pagename|runs| 09:50:45 INFO - PROCESS | 1758 | |0;ai-astar;110;115;118;115;115;116;113;117;115;114 09:50:45 INFO - PROCESS | 1758 | |1;audio-beat-detection;148;125;131;179;127;130;129;132;161;134 09:50:45 INFO - PROCESS | 1758 | |2;audio-dft;161;160;163;162;162;160;162;160;159;160 09:50:45 INFO - PROCESS | 1758 | |3;audio-fft;75;76;76;109;88;76;77;76;98;75 09:50:45 INFO - PROCESS | 1758 | |4;audio-oscillator;84;84;112;83;83;84;119;83;83;121 09:50:45 INFO - PROCESS | 1758 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 09:50:45 INFO - PROCESS | 1758 | |6;imaging-darkroom;147;147;146;146;145;147;147;147;146;146 09:50:45 INFO - PROCESS | 1758 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;95;95 09:50:45 INFO - PROCESS | 1758 | |8;json-parse-financial;63;61;62;61;63;67;63;62;64;63 09:50:45 INFO - PROCESS | 1758 | |9;json-stringify-tinderbox;67;67;68;69;67;67;67;67;67;67 09:50:45 INFO - PROCESS | 1758 | |10;stanford-crypto-aes;90;83;84;84;92;82;93;83;84;92 09:50:45 INFO - PROCESS | 1758 | |11;stanford-crypto-ccm;140;141;140;145;136;147;137;136;172;157 09:50:45 INFO - PROCESS | 1758 | |12;stanford-crypto-pbkdf2;174;173;173;178;172;173;180;175;178;176 09:50:45 INFO - PROCESS | 1758 | |13;stanford-crypto-sha256-iterative;70;70;71;69;68;71;69;70;69;70 09:50:45 INFO - PROCESS | 1758 | __end_tp_report 09:50:45 INFO - PROCESS | 1758 | __start_cc_report 09:50:45 INFO - PROCESS | 1758 | _x_x_mozilla_cycle_collect,1940 09:50:45 INFO - PROCESS | 1758 | __end_cc_report 09:50:45 INFO - PROCESS | 1758 | __startTimestamp1475686245140__endTimestamp 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | ------- Summary: start ------- 09:50:45 INFO - PROCESS | 1758 | Number of tests: 14 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:2.20 (1.9%) stddev-sans-first:1.50 09:50:45 INFO - PROCESS | 1758 | Values: 110.0 115.0 118.0 115.0 115.0 116.0 113.0 117.0 115.0 114.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:133.00 stddev:17.70 (13.3%) stddev-sans-first:18.51 09:50:45 INFO - PROCESS | 1758 | Values: 148.0 125.0 131.0 179.0 127.0 130.0 129.0 132.0 161.0 134.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.29 (0.8%) stddev-sans-first:1.36 09:50:45 INFO - PROCESS | 1758 | Values: 161.0 160.0 163.0 162.0 162.0 160.0 162.0 160.0 159.0 160.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:11.95 (15.7%) stddev-sans-first:12.35 09:50:45 INFO - PROCESS | 1758 | Values: 75.0 76.0 76.0 109.0 88.0 76.0 77.0 76.0 98.0 75.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:83.00 stddev:16.53 (19.9%) stddev-sans-first:17.17 09:50:45 INFO - PROCESS | 1758 | Values: 84.0 84.0 112.0 83.0 83.0 84.0 119.0 83.0 83.0 121.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:50:45 INFO - PROCESS | 1758 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:50:45 INFO - PROCESS | 1758 | Values: 147.0 147.0 146.0 146.0 145.0 147.0 147.0 147.0 146.0 146.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:50:45 INFO - PROCESS | 1758 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:1.73 (2.7%) stddev-sans-first:1.83 09:50:45 INFO - PROCESS | 1758 | Values: 63.0 61.0 62.0 61.0 63.0 67.0 63.0 62.0 64.0 63.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 09:50:45 INFO - PROCESS | 1758 | Values: 67.0 67.0 68.0 69.0 67.0 67.0 67.0 67.0 67.0 67.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.00 stddev:4.45 (5.1%) stddev-sans-first:4.56 09:50:45 INFO - PROCESS | 1758 | Values: 90.0 83.0 84.0 84.0 92.0 82.0 93.0 83.0 84.0 92.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:143.00 stddev:11.40 (8.0%) stddev-sans-first:11.94 09:50:45 INFO - PROCESS | 1758 | Values: 140.0 141.0 140.0 145.0 136.0 147.0 137.0 136.0 172.0 157.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:175.50 stddev:2.70 (1.5%) stddev-sans-first:2.83 09:50:45 INFO - PROCESS | 1758 | Values: 174.0 173.0 173.0 178.0 172.0 173.0 180.0 175.0 178.0 176.0 09:50:45 INFO - PROCESS | 1758 | 09:50:45 INFO - PROCESS | 1758 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 09:50:45 INFO - PROCESS | 1758 | Values: 70.0 70.0 71.0 69.0 68.0 71.0 69.0 70.0 69.0 70.0 09:50:45 INFO - PROCESS | 1758 | -------- Summary: end -------- 09:50:45 INFO - PROCESS | 1758 | 09:50:46 INFO - TEST-INFO | 1758: exit 0 09:50:46 INFO - TEST-OK | kraken | took 64882ms 09:50:46 INFO - SUITE-END | took 1186s 09:50:46 INFO - Completed test suite (00:19:46) 09:50:46 INFO - javascript benchmark 09:50:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2537.3149249702583, 2548.388386787169, 2606.804489663276, 2612.490564339954, 2618.345413646587, 4567.177907976571, 4598.51715569865, 4600.516945720701, 4607.907841843161, 4609.0, 4615.69997950133, 4637.35077089207, 4645.396098507189, 4667.15991121598, 4729.266963620636, 4197.811098500575, 4212.831486740527, 4260.914781704364, 4297.806598703066, 4307.0, 4279.61483466488, 4301.397804307399, 4318.244307246235, 4334.263175260214, 4365.279728844736, 4205.684573656958, 4325.113351762881, 4335.349697545377, 4342.6742994275555, 4438.400815889862, 4235.322348424237, 4237.4279472271155, 4271.188474189925, 4284.100338928829, 4307.052448461333, 4256.0, 4256.08494173751, 4271.786410679453, 4306.720063195914, 4316.719413238129, 4596.954030459686, 4602.148602508547, 4626.259798432268, 4634.328022436762, 4677.836275730333, 4746.976265118652, 4779.689320194177, 4929.1620424527555, 4946.975265123651, 4976.800927962877, 4972.850814475535, 5004.724740139291, 5009.0983622948215, 5014.097462456756, 5039.874003149914, 4668.6731928765, 4674.719516829001, 4677.415323084614, 4677.812887484531, 4734.384530011076, 4950.777215025332, 5004.724740139254, 5063.341765570526, 5111.897762044739, 5173.094708426011, 4878.048780487771, 4907.288443175719, 4910.288008238786, 4965.751712414437, 4969.627277954168, 4964.528369804862, 4976.8755781105765, 4986.326845875833, 4987.127252730757, 5051.015052064886, 4824.300476430898, 4866.29438731389, 4943.826966056171, 4953.876153096201, 5017.698938063728, 4848.224284114595, 4904.043711476228, 4904.5340692634145, 4916.434610019894, 4976.0, 4170.83316667336, 4197.97901010493, 4201.768902710319, 4202.453681021448, 4256.212600668886, 3645.54430696163, 3696.9260614787554, 3711.1464363196615, 3726.2920045191327, 3735.9626403735615, 4249.5113061997645, 4270.017895883964, 4299.484061912528, 4299.935500967488, 4362.956370436318, 4997.750112494361, 5001.424836143818, 5043.36957880265, 5047.646664733506, 5099.464556221617, 4298.398224248608, 4303.440552728125, 4306.5262821089655, 4314.007778211029, 4364.978175109104, 4442.044960333544, 4462.44219472566, 4472.709273897186, 4479.10417916418, 4512.638988880882, 4659.277811939155, 4670.416197975253, 4688.507706690748, 4698.694584851974, 4718.646101542329, 4965.950340496694, 4976.427710813303, 4977.726225057657, 4986.227134794112, 5043.823466178666, 4545.363649089196, 4581.816727330869, 4620.052889157648, 4636.652251081115, 4647.721136731807, 4874.902501950012, 4898.853034408973, 4902.362692849907, 4941.703497790144, 4960.72716000609, 4962.950370496249, 4974.353334066548, 4976.054549635558, 4978.925316120333, 5038.445770965264, 4684.414448193976, 4759.643026773075, 4770.379850619536, 4851.102546028996, 4908.484609116134, 4846.151923413459, 4881.658283920092, 4889.364382630235, 4927.778249978688, 4941.530554597308, 4779.498152693917, 4802.351682522814, 4803.615710743202, 4816.927746083741, 4879.804807807648, 4751.477337492942, 4779.976100119477, 4806.255030470283, 4825.734584597881, 4860.586850117779, 4758.762061896822, 4791.089692958327, 4831.661783675109, 4836.588889944394, 4844.031193761191], "value": 4564.753916450461, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.719140429785, 575.2808988764042, 577.6938222741949, 580.396387756733, 580.509469498274, 28065.43869122616, 38702.61297387025, 39793.80103099488, 39804.40293395598, 43356.349654755206, 40028.59971400285, 40482.39276410856, 40500.59499405005, 40513.189736205255, 40559.79720101396, 7562.88655670164, 7689.423293253, 7719.112302085247, 7725.49784264021, 7726.42051846111, 7261.128664560234, 7445.627718614075, 9658.613655453773, 9945.850812237823, 9946.055124763172, 9766.072223138826, 9841.45871977041, 9856.26078044146, 9859.260555458333, 9863.654772082979, 9939.40363578184, 10032.498375081217, 10033.04686054831, 10034.698959031204, 10042.497875106215, 9414.293927955363, 9549.09283618055, 9559.0, 9562.043795620451, 9569.569369378394, 36973.0, 37106.443403348974, 37198.814005929795, 37280.62719372799, 37280.62719372826, 2691.3540750220004, 3127.53087036944, 3138.4978403455566, 3142.230153612357, 3172.6510083890753, 27632.309192270153, 27972.300692482648, 28999.39005489516, 29121.708782912112, 29170.311789201114, 3284.655111213312, 3402.6767457091537, 3421.6578342165585, 3465.358908601917, 3479.5302634144573, 205520.0, 259419.0, 262317.0, 262583.0, 262895.0, 52639.473605263454, 53085.734571326895, 53099.73450132802, 53101.0, 53120.734396327774, 32722.83638581792, 33119.3376132476, 33333.0, 35415.645843541235, 35426.29147417037, 13092.149010314299, 13228.338583071001, 13232.272225027717, 13251.602451926265, 13255.536056237985, 9354.71935841926, 9590.42457452555, 9810.215182785503, 9919.900800991898, 9928.851067233998, 17048.659026819394, 17298.65402691964, 17472.213750381263, 18343.35798247055, 18407.355742548945, 6544.247411547638, 6622.086606505276, 6626.337366263431, 6635.0, 6920.9653951729915, 734.181387752652, 829.4442723375353, 844.7254642241296, 857.8756080368312, 927.893292271384, 26085.347866303495, 27603.447931041268, 28097.157085287476, 28299.43401131966, 28366.290842728686, 873.3144481582054, 909.5906841921029, 919.4299534288783, 939.6429356844492, 970.2432102959702, 14285.285735713172, 14792.63018424548, 14833.258337083103, 14976.850231497763, 15106.244687765568, 369783.0, 373544.0, 373568.0, 373748.0, 374072.0, 31903.52144717831, 48357.758211209424, 48408.75795620999, 48539.271910921365, 48551.271730923356, 1063.1229235880276, 1071.4374953149659, 1114.0864491117206, 1147.7474955509942, 1161.703765539799, 25384.492310154063, 28884.0, 29325.413491729618, 29851.552226717053, 29899.0, 41207.1758564833, 41765.791171045166, 41792.3731144027, 41816.1636767269, 41846.16307673891, 236438.0, 236615.0, 236632.0, 236695.0, 236823.0, 24788.0, 25088.0, 25562.36094097588, 25563.0, 26876.865615672577, 39520.60479395284, 39885.2022959545, 40130.39804402995, 40862.387064194656, 40888.0, 31210.0, 31542.0, 31594.628913084372, 31699.683003169674, 32489.512657309686, 34199.0, 34511.4823277646, 34835.303293934485, 34934.47598285977, 35229.0, 33765.97404155759, 34245.82877085599, 34565.48151777776, 34621.65378346184, 34882.825585871906, 30095.24761880883, 31404.0, 31716.682833171373, 31993.360132796748, 32014.51978220375, 24627.384315392257, 24770.0, 24829.92857499582, 24864.87567562223, 25205.0], "value": 17050.194234341638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.049628806047, 342.52218155672836, 355.5537800060923, 358.29416050380746, 375.36375842946217, 11999.940000300008, 15574.766378504331, 15863.444779432708, 16719.49841504754, 16901.323947042103, 13960.301984900765, 14855.0, 16701.665966680688, 17075.060871652055, 17219.225134868928, 4117.876463706094, 4830.686005409637, 4920.557149856512, 5122.282880396729, 5143.099957507421, 5058.924116138261, 5146.74266286686, 5148.124818780816, 5151.4333423323405, 5152.510511501401, 5115.079285728568, 5119.232115182734, 5123.948760512403, 6570.178727659043, 6931.896021559681, 6831.69257383419, 6879.140107486539, 7032.929670703279, 7061.329173728487, 7064.222935477068, 6795.490338224653, 6904.758333458355, 6910.861782764367, 6915.619640919747, 6917.7232910683515, 22440.438989025242, 22814.771852281596, 22847.42881427961, 22927.426814329774, 23025.309240722807, 1792.7310903364469, 1918.2518817661123, 1953.8925359105244, 1986.4934441717414, 2078.158345869925, 13684.384202710902, 13884.23636699981, 13896.374663140183, 14737.778933316009, 15343.923280383638, 1837.0, 1846.2153584726573, 1850.4448665400325, 1909.3794516782102, 1921.6541022615922, 65889.67055164694, 82652.0, 83509.0, 83862.71924567534, 86865.56567217123, 15814.9209253953, 15926.203689815462, 16175.838241617434, 16195.433159839584, 16707.415240466526, 28307.0, 28332.433351332857, 28415.28961775972, 28671.283217919303, 28717.28206794847, 8058.677652893936, 8322.791930201793, 8383.371247156487, 8459.407841451162, 8569.95715021421, 6673.432758215509, 6892.760402610765, 6895.793126206222, 6924.307569243036, 7070.717171313193, 8174.3460523158, 8199.631016604148, 8253.422260441832, 8256.876146857801, 8372.665093396317, 3190.920226994297, 3195.7762956592815, 3284.8850290240207, 3298.752593555493, 3366.7342677603174, 752.6048824367251, 769.8768197088439, 776.2703059124404, 808.1837344282317, 886.9512176830336, 15632.92183539075, 16291.348346066261, 16519.174041297887, 16982.830171698373, 17321.0, 844.6959094725894, 844.7930257087053, 844.936629752771, 888.8711136885115, 906.207068814787, 9139.314551408672, 9310.767230819149, 9539.761505962268, 9547.42715437076, 9687.612495500241, 349734.0, 355339.0, 355501.0, 356876.0, 358805.0, 46557.0, 49868.0, 65832.01251981224, 70746.0, 72310.63844680742, 856.3472498078644, 862.4825104937113, 890.9020007799137, 898.6764764684708, 903.051795614602, 11024.50389732448, 14085.718285634024, 15156.469523566622, 15475.071495710294, 15736.68526629438, 37464.250714985, 37693.81153094217, 37870.24259514849, 38078.0, 39481.0, 48626.756866215444, 48683.269750953055, 48899.0, 49161.10066792008, 49466.25800613066, 7215.242399547972, 7259.274072592699, 7277.417806575567, 7316.817079573053, 7832.0, 7938.0, 9843.557039933363, 11822.527098915947, 11833.52665893389, 12258.448369823558, 9707.271954603291, 9870.0, 10051.0, 10129.139023182817, 10416.791664166825, 10168.389896606228, 10213.846792297973, 10215.94892025535, 10347.793044139225, 10366.222533309881, 10213.846792297973, 10287.279890407899, 10380.792384152426, 10659.4137322448, 10827.350358978487, 7187.425005999612, 7335.889961650686, 7427.777166684792, 7430.108386993596, 7528.661210245662, 8937.195652391316, 9879.30844840883, 9975.950120249352, 10098.727786248035, 10237.9488102559], "value": 8883.441520528615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.2311078686605, 1292.302156835309, 1312.8250216056629, 1624.301550333356, 1628.4463282483969, 6833.077534532837, 7044.647767611625, 7412.629368531579, 8075.434719569633, 8075.798105047376, 7113.253108423606, 7383.5200711953685, 7387.5936823474685, 7553.924460755391, 7557.84884302315, 2070.9378718638427, 2095.182878677317, 2096.695979083032, 2102.7581828089815, 2106.199644135234, 1827.8994655293955, 1891.1206289075576, 2045.4988527810708, 2064.194963964055, 2075.8650687705326, 1944.9222031118738, 1999.9300024499146, 2002.269171752307, 2011.859169858103, 2014.1641218894142, 2012.154894944127, 2030.4416285521452, 2034.837213022962, 2039.479932617173, 2041.4590133614604, 1951.677973134431, 1955.0908827395187, 1960.8235258826774, 1964.9705254421194, 1966.2724791826972, 7502.512336698152, 7559.69761209551, 7562.470627056108, 7568.659410326549, 7569.432292578079, 4335.913281734348, 4440.866773996753, 4528.1622899763315, 4533.478649955265, 4535.229011068126, 2657.760801527872, 2800.131959092688, 2812.592174134739, 2815.9296017599518, 2826.462972035307, 832.508819796317, 843.8101427178897, 887.352232870002, 891.9821603567892, 894.8120894612074, 10556.313839600478, 10631.574737010511, 10637.521311540999, 10650.786984260349, 10660.946695266473, 3805.9429108563395, 3939.940900886489, 3961.2869683457257, 4116.135611521614, 4125.525564560054, 9175.44947303164, 9186.40288381253, 9190.678326258549, 9237.168654821098, 9271.768205794775, 4404.295312749945, 4408.096340250241, 4411.713238639478, 4413.801378937956, 4415.5363686812425, 4010.6991975601945, 4024.8188831502653, 4045.211183819186, 4051.716379853441, 4053.5338436079637, 3534.4874993125854, 3556.2354093869944, 3633.8364773585254, 3633.8909832705062, 3668.284684486553, 1042.8592140061146, 1080.6487891435315, 1159.2986243322837, 1164.394514852272, 1170.104869774623, 674.6120980436269, 686.5262968551683, 697.2817997462622, 738.5384134915678, 766.4673052228648, 4818.951810481921, 4867.5132486751045, 4927.77824997876, 4973.179425394842, 5120.743962801845, 766.2490759056157, 772.2162005564356, 781.9648115834801, 829.1169904052165, 867.6572753762229, 3297.934041319208, 3314.950275745866, 3362.9495557566656, 3395.168183794986, 3445.0, 9518.286128540387, 9954.054364835329, 9955.900440995641, 9962.750931226632, 9975.600975961026, 9912.702618921443, 9942.900570994341, 9943.651972180938, 9943.950280248697, 9945.999999999854, 7291.817704557322, 7327.890081648886, 7337.266273372727, 7475.775726728207, 7489.176190619028, 4819.1566475867285, 4864.73243971585, 4870.9269360960325, 4895.143349913679, 5014.147594908802, 8753.387262891536, 8857.734267971971, 8864.113588641085, 8960.417572857743, 9012.594433250388, 8772.078931712078, 9186.356955013085, 9298.628054877729, 9308.208802251613, 9310.720678379388, 6109.908351374644, 6199.318075011835, 6261.5616906816085, 6261.592996455216, 6265.718042687999, 7297.927020729725, 7317.67070481819, 7327.157376901724, 7330.157031941182, 7336.559806411632, 6615.338466153346, 6685.197776266879, 6700.698468569024, 6705.631190284386, 6818.761343353157, 6332.588381755171, 6545.934540654723, 6547.148870646785, 6577.835554111186, 6724.058631791455, 5844.211031510692, 6083.939160608337, 6097.908531372122, 6109.572329936862, 6113.327533971348, 4317.201317756225, 4373.540778218241, 4415.2494076006515, 4444.733316000921, 4492.326151077234, 4345.2395830728865, 4377.146456440963, 4497.235469970178, 4554.476235232991, 4568.4974652787505], "value": 3979.7898963829366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.3781542790433, 285.9456703226387, 288.8454676747939, 291.53791240883197, 296.17367544550706, 4816.855494335166, 4863.61091112711, 4877.5122487751205, 4882.462024462301, 4924.458309585947, 4505.57197066279, 4777.474477807438, 4805.81335492351, 4830.468648448667, 4840.0, 3647.452882067691, 3662.633736626343, 3732.64539868712, 3800.5439347278366, 3809.961900381002, 3762.3980163173896, 3787.791671458069, 3795.4496597993275, 3801.1257410795533, 3805.9429108563395, 3549.822508874559, 3737.962620373802, 3742.3263812513737, 3768.1144930941205, 3786.8295926683363, 3642.508261384719, 3654.1778099927437, 3704.944090934098, 3737.9439308410124, 3746.344389731786, 3312.337532493487, 3313.2710803623163, 3313.7349012079217, 3325.5676762021026, 3328.9667103328898, 4691.437027556715, 4696.882577935545, 4706.576408123286, 4707.176244157259, 4722.83470078549, 4176.387424877489, 4254.170436764832, 4285.185814695229, 4303.677224208165, 4347.217500849846, 4990.476000019982, 4994.800207991676, 4996.12567800637, 4999.475055119233, 5003.3495645565845, 3596.6692323840084, 3597.4244120940784, 3605.873794417209, 3611.5846677632144, 3615.493830863681, 5076.213186956028, 5223.1642937130255, 5231.189165679288, 5302.840914772563, 5309.734513274321, 3688.870889518854, 3694.113412780913, 3698.223373091681, 3714.3285521515427, 3721.925561488755, 3748.8687895923513, 3755.5493340798735, 3758.793266370376, 3761.1161377076364, 3763.8682646107254, 4279.272523670983, 4281.571842815693, 4296.656267498593, 4300.548442413564, 4333.133373325348, 4916.237983112624, 5030.773615187325, 5032.245163225472, 5032.572231360376, 5119.846404607868, 1278.8721127887136, 1290.9289989050692, 1293.359786905469, 1294.9417276222594, 1298.1756584568866, 839.8320335932838, 842.2461896602506, 843.1947490146895, 847.9576021198916, 866.8136350684633, 4317.977415808947, 4331.198728235224, 4356.651467882625, 4453.888652783707, 4475.194464996332, 5156.793728250828, 5160.7419629018395, 5184.7407629618365, 5197.0, 5204.4014938281825, 4275.935860962088, 4403.229434848953, 4403.713758605681, 4419.513853476115, 4420.961074147637, 2728.140635699748, 2728.508868403667, 2744.2041807875894, 2757.648752111451, 2762.1575419497244, 4854.393200849894, 4860.975695121501, 4862.82980095695, 4891.51084891508, 4904.901901962012, 5107.8723031923755, 5252.868678282997, 5307.150855863043, 5322.520973112361, 5354.3842458117815, 4781.545753153445, 4815.0, 4824.094482679392, 4826.334914454507, 4827.879303017382, 5130.794263348035, 5162.612804039637, 5169.0, 5189.365349914765, 5197.298364720866, 4998.150314446625, 5051.2825639281355, 5056.62075344358, 5089.236614507853, 5158.329417175743, 4837.588804951478, 4866.464688884291, 4866.683665561727, 4874.268859671078, 4877.292792545132, 3693.390590552529, 3705.351563476327, 3710.7959062251834, 3728.086618778417, 3729.086373838427, 5001.174806156943, 5160.845174644766, 5170.767315470737, 5201.921971170511, 5284.762185701729, 5050.545450909436, 5056.721880296619, 5067.949320506747, 5069.645124841226, 5088.414832294334, 5029.572486338556, 5039.143345631325, 5060.620453465931, 5086.313347698014, 5090.643654944267, 4751.762411879461, 4989.276554899447, 4992.950070499393, 5016.548510633915, 5027.773750181177, 4856.805727770849, 4964.578010869117, 5028.874278143076, 5128.512731307879, 5158.200478925773, 4980.950190498049, 4994.850154495226, 5008.398992120969, 5014.749262536786, 5033.798648054037], "value": 3795.471801790989, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.5162237908967, 582.3972188784608, 587.3509771702269, 611.3794498583939, 644.1818890009685, 10914.454277286133, 11425.828612570807, 11444.885551144485, 11482.425878706052, 11583.18917675763, 11301.773964520704, 11402.543898244081, 11406.71483212918, 11409.20135590509, 11411.372374519418, 610.8900397928371, 614.7602435050334, 621.0404924391826, 737.4985010193067, 761.6839011810092, 729.1905984357359, 737.0344848248784, 738.3059923671732, 749.3518106837573, 752.8720117580025, 793.9563324017206, 796.1839114907237, 796.3151689546985, 797.0117054852, 797.0594698256056, 637.5186734015834, 654.2770238886058, 767.8464307138539, 793.1830214878655, 793.7499687598388, 568.6957477749385, 576.622312385384, 580.4717706886713, 580.9796657116981, 581.0818906128308, 12763.489460421571, 12776.0, 12795.552155674506, 12803.48786048557, 12805.55180568685, 12037.939810300892, 12354.629361119181, 12775.744485110246, 12815.487380504768, 12995.0, 9713.61145554184, 9719.805603887882, 9793.21654267657, 10410.635627753069, 11180.44097795107, 4108.116754897682, 4115.773632450214, 4121.155163191568, 4122.6083522065655, 4313.762743049131, 58449.12326315109, 58658.413415865725, 59036.0, 59566.702166489325, 59733.40266597322, 9368.2973776967, 10058.14505767018, 10080.0, 10329.431881246604, 10464.21518386124, 16752.24614892333, 16883.0, 16884.0, 16890.071046092336, 16920.153992300337, 6215.12988181655, 6305.779297724557, 6329.873402531924, 6434.613923164625, 6439.967800160969, 3318.1538707629884, 3442.3631628148373, 3450.413429716954, 3472.2361080562237, 3536.929261414809, 2620.7772339350986, 2734.412101398169, 2734.644496215479, 2740.10946442407, 2741.9588706169425, 517.1338008835186, 533.4931814775979, 543.5760107116455, 544.276112770015, 550.6640949021094, 515.7885267040496, 523.9337947277348, 524.5410266017235, 556.4769117029979, 579.8927198468213, 7264.491485595958, 7333.267070867664, 7881.408894332948, 8443.451175673561, 8509.957450212709, 484.1962342511414, 495.07174048658766, 545.939946605873, 550.8512701570553, 572.718926027946, 3958.44581758554, 3964.1278918637854, 4046.858359957387, 4054.878353649395, 4130.648894843972, 74056.25943740601, 74966.0, 89084.0, 98773.0, 101358.0, 71894.0, 72310.63844680849, 72380.63809680918, 73742.0, 74856.25143748493, 63914.0, 65713.0, 66861.99999999903, 66953.0, 69214.30785692179, 8543.273821724973, 8990.730278091667, 9189.310801690033, 9201.815963680823, 9305.674301399418, 40740.185196295315, 41155.58844411517, 41619.37570936499, 41689.37465938074, 43198.78400608103, 53204.0, 57344.71327643335, 59390.40609594022, 59943.40056599553, 62955.0, 10992.230543861853, 11178.441077945907, 11255.268407553483, 11536.134789890959, 11945.16383853122, 12028.939855301018, 12127.784958377186, 12393.318367489876, 12460.391797365592, 13378.598642040753, 11923.642290731292, 12005.739795918493, 12157.209781364183, 12364.505419783109, 12929.806052909402, 11747.706307342385, 11906.107041971714, 12689.682757931125, 12847.229166249681, 12911.935440323114, 11747.647570572555, 11983.0, 12849.807252891402, 12985.091043626855, 13050.34748262602, 8964.238039766693, 9175.816483670156, 9314.115159059878, 9407.670731524637, 9527.523623818919, 9768.462734549385, 10557.313774604627, 10821.945890270814, 10913.618023369145, 10932.234743568191], "value": 6314.416962763393, "unit": "score"}], "name": "dromaeo_css", "value": 6356.330891440785, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 118.0, 115.0, 115.0, 116.0, 113.0, 117.0, 115.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 131.0, 179.0, 127.0, 130.0, 129.0, 132.0, 161.0, 134.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 162.0, 162.0, 160.0, 162.0, 160.0, 159.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 109.0, 88.0, 76.0, 77.0, 76.0, 98.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 83.0, 83.0, 84.0, 119.0, 83.0, 83.0, 121.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 145.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 61.0, 63.0, 67.0, 63.0, 62.0, 64.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 69.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 84.0, 84.0, 92.0, 82.0, 93.0, 83.0, 84.0, 92.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 140.0, 145.0, 136.0, 147.0, 137.0, 136.0, 172.0, 157.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 173.0, 178.0, 172.0, 173.0, 180.0, 175.0, 178.0, 176.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 69.0, 68.0, 71.0, 69.0, 70.0, 69.0, 70.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1556.9, "alertThreshold": 2.0}]} 09:50:46 INFO - Return code: 0 09:50:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:50:46 INFO - # TBPL SUCCESS # 09:50:46 INFO - Running post-action listener: _resource_record_post_action 09:50:46 INFO - [mozharness: 2016-10-05 16:50:46.960526Z] Finished run-tests step (success) 09:50:46 INFO - Running post-run listener: _resource_record_post_run 09:50:47 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392159232; Read time: 12; Write time: 233872 09:50:47 INFO - TinderboxPrint: CPU usage
13.0% 09:50:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:50:47 INFO - TinderboxPrint: I/O write bytes / time
392,159,232 / 233,872 09:50:47 INFO - TinderboxPrint: CPU idle
8,347.1 (87.0%) 09:50:47 INFO - TinderboxPrint: CPU user
1,203.8 (12.5%) 09:50:47 INFO - TinderboxPrint: Swap in / out
0 / 0 09:50:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99123200; Read time: 0; Write time: 56640 09:50:47 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293036032; Read time: 0; Write time: 177232 09:50:47 INFO - Running post-run listener: _upload_blobber_files 09:50:47 INFO - Blob upload gear active. 09:50:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:50:47 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 09:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:50:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:50:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:48 INFO - (blobuploader) - INFO - Done attempting. 09:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:50:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:49 INFO - (blobuploader) - INFO - Done attempting. 09:50:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:50:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:50:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:52 INFO - (blobuploader) - INFO - Done attempting. 09:50:52 INFO - (blobuploader) - INFO - Iteration through files over. 09:50:52 INFO - Return code: 0 09:50:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:50:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:50:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e63e65b87ed55c9a929f97e5df5b257454fd2221e10879f2706e5b7d309174c088fb2322a819bb63c2de3dc1329c4c0aaa98ce4405a78a08e1d82cab2276a33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12936b484c8193ebc28fd6731da5cb82b6fc0ccc8cea2efed778eb1b1d11b9dc72f58ac17dfb8fe22c017cf5b72d6b97087fabe4da33f21aff9a04b0049b522e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ddd6d46b0cae86ee8f0fe08ea60a3fbcdac9d3fb45f939640d25b36134ec09fe1dca0f10e3c1d762a15fa60801a3ba38d42330a55618a9666f192e4ee0b8610c"} 09:50:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:50:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:50:52 INFO - Contents: 09:50:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e63e65b87ed55c9a929f97e5df5b257454fd2221e10879f2706e5b7d309174c088fb2322a819bb63c2de3dc1329c4c0aaa98ce4405a78a08e1d82cab2276a33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12936b484c8193ebc28fd6731da5cb82b6fc0ccc8cea2efed778eb1b1d11b9dc72f58ac17dfb8fe22c017cf5b72d6b97087fabe4da33f21aff9a04b0049b522e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ddd6d46b0cae86ee8f0fe08ea60a3fbcdac9d3fb45f939640d25b36134ec09fe1dca0f10e3c1d762a15fa60801a3ba38d42330a55618a9666f192e4ee0b8610c"} 09:50:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:50:52 INFO - Copying logs to upload dir... 09:50:52 INFO - mkdir: /builds/slave/test/build/upload/logs 09:50:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.791153 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-05 09:50:52.693051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 09:50:52.696627) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e63e65b87ed55c9a929f97e5df5b257454fd2221e10879f2706e5b7d309174c088fb2322a819bb63c2de3dc1329c4c0aaa98ce4405a78a08e1d82cab2276a33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12936b484c8193ebc28fd6731da5cb82b6fc0ccc8cea2efed778eb1b1d11b9dc72f58ac17dfb8fe22c017cf5b72d6b97087fabe4da33f21aff9a04b0049b522e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ddd6d46b0cae86ee8f0fe08ea60a3fbcdac9d3fb45f939640d25b36134ec09fe1dca0f10e3c1d762a15fa60801a3ba38d42330a55618a9666f192e4ee0b8610c"} build_url:https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/fE8D4byLTZGVPCsnmOOC5w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e63e65b87ed55c9a929f97e5df5b257454fd2221e10879f2706e5b7d309174c088fb2322a819bb63c2de3dc1329c4c0aaa98ce4405a78a08e1d82cab2276a33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12936b484c8193ebc28fd6731da5cb82b6fc0ccc8cea2efed778eb1b1d11b9dc72f58ac17dfb8fe22c017cf5b72d6b97087fabe4da33f21aff9a04b0049b522e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ddd6d46b0cae86ee8f0fe08ea60a3fbcdac9d3fb45f939640d25b36134ec09fe1dca0f10e3c1d762a15fa60801a3ba38d42330a55618a9666f192e4ee0b8610c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 09:50:52.722634) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:50:52.722970) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475685005.182392-1025930486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 09:50:52.807989) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 09:50:52.808454) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 09:50:52.808818) ========= ========= Total master_lag: 0.18 =========