builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1475284438.69 results: success (0) buildid: 20160930153004 builduid: 4324de83c1f34e58ae86790f2a042386 revision: d69d58af9bea7a2781304d3ee3ba2122b2c07abf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 18:13:58.694690) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 18:13:58.695157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 18:13:58.695502) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 18:13:58.714694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:13:58.715175) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 18:14:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.6M=0s 2016-09-30 18:14:00 (28.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:13:58.844982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:13:58.845412) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018957 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:13:58.899020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-09-30 18:13:58.899830) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d69d58af9bea7a2781304d3ee3ba2122b2c07abf --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 d69d58af9bea7a2781304d3ee3ba2122b2c07abf --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=82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 18:14:00,466 truncating revision to first 12 chars 2016-09-30 18:14:00,466 Setting DEBUG logging. 2016-09-30 18:14:00,467 attempt 1/10 2016-09-30 18:14:00,467 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d69d58af9bea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 18:14:07,781 unpacking tar archive at: fx-team-d69d58af9bea/testing/mozharness/ program finished with exit code 0 elapsedTime=7.735623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-09-30 18:14:06.649346) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 18:14:06.649739) ========= script_repo_revision: d69d58af9bea7a2781304d3ee3ba2122b2c07abf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 18:14:06.650243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 18:14:06.650572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 18:14:06.661485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-30 18:14:06.661792) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:14:08 INFO - MultiFileLogger online at 20160930 18:14:08 in /builds/slave/test 18:14:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:14:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:14:08 INFO - {'append_to_log': False, 18:14:08 INFO - 'base_work_dir': '/builds/slave/test', 18:14:08 INFO - 'blob_upload_branch': 'Fx-Team', 18:14:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:14:08 INFO - 'branch': 'Fx-Team', 18:14:08 INFO - 'buildbot_json_path': 'buildprops.json', 18:14:08 INFO - 'config_files': ('talos/linux_config.py',), 18:14:08 INFO - 'default_actions': ('clobber', 18:14:08 INFO - 'read-buildbot-config', 18:14:08 INFO - 'download-and-extract', 18:14:08 INFO - 'populate-webroot', 18:14:08 INFO - 'create-virtualenv', 18:14:08 INFO - 'install', 18:14:08 INFO - 'run-tests'), 18:14:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:14:08 INFO - 'download_minidump_stackwalk': True, 18:14:08 INFO - 'download_symbols': 'ondemand', 18:14:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:14:08 INFO - 'tooltool.py': '/tools/tooltool.py', 18:14:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:14:08 INFO - '/tools/misc-python/virtualenv.py')}, 18:14:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:14:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:14:08 INFO - 'installer_path': 'installer.exe', 18:14:08 INFO - 'log_level': 'info', 18:14:08 INFO - 'log_name': 'talos', 18:14:08 INFO - 'log_to_console': True, 18:14:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:14:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:14:08 INFO - 'opt_config_files': (), 18:14:08 INFO - 'pip_index': False, 18:14:08 INFO - 'sps_profile': False, 18:14:08 INFO - 'sps_profile_interval': 0, 18:14:08 INFO - 'suite': 'dromaeojs-e10s', 18:14:08 INFO - 'system_bits': '32', 18:14:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:14:08 INFO - 'title': 'talos-linux64-ix-066', 18:14:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:14:08 INFO - 'use_talos_json': True, 18:14:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:14:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:14:08 INFO - 'work_dir': 'build'} 18:14:08 INFO - [mozharness: 2016-10-01 01:14:08.321257Z] Running clobber step. 18:14:08 INFO - Running pre-action listener: _resource_record_pre_action 18:14:08 INFO - Running main action method: clobber 18:14:08 INFO - rmtree: /builds/slave/test/build 18:14:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:14:08 INFO - Running post-action listener: _resource_record_post_action 18:14:08 INFO - [mozharness: 2016-10-01 01:14:08.780875Z] Finished clobber step (success) 18:14:08 INFO - [mozharness: 2016-10-01 01:14:08.780977Z] Running read-buildbot-config step. 18:14:08 INFO - Running pre-action listener: _resource_record_pre_action 18:14:08 INFO - Running main action method: read_buildbot_config 18:14:08 INFO - Using buildbot properties: 18:14:08 INFO - { 18:14:08 INFO - "project": "", 18:14:08 INFO - "product": "firefox", 18:14:08 INFO - "script_repo_revision": "production", 18:14:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:14:08 INFO - "repository": "", 18:14:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 18:14:08 INFO - "buildid": "20160930153004", 18:14:08 INFO - "pgo_build": "True", 18:14:08 INFO - "basedir": "/builds/slave/test", 18:14:08 INFO - "buildnumber": 784, 18:14:08 INFO - "slavename": "talos-linux64-ix-066", 18:14:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:14:08 INFO - "platform": "ubuntu64_hw", 18:14:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:14:08 INFO - "branch": "fx-team", 18:14:08 INFO - "repo_path": "integration/fx-team", 18:14:08 INFO - "revision": "d69d58af9bea7a2781304d3ee3ba2122b2c07abf", 18:14:08 INFO - "stage_platform": "linux64-pgo", 18:14:08 INFO - "builduid": "4324de83c1f34e58ae86790f2a042386", 18:14:08 INFO - "slavebuilddir": "test" 18:14:08 INFO - } 18:14:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:14:08 INFO - Running post-action listener: _resource_record_post_action 18:14:08 INFO - [mozharness: 2016-10-01 01:14:08.783398Z] Finished read-buildbot-config step (success) 18:14:08 INFO - [mozharness: 2016-10-01 01:14:08.783486Z] Running download-and-extract step. 18:14:08 INFO - Running pre-action listener: _resource_record_pre_action 18:14:08 INFO - Running main action method: download_and_extract 18:14:08 INFO - mkdir: /builds/slave/test/build/tests 18:14:08 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')]} 18:14:08 INFO - trying https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:14:08 INFO - Downloading https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/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 18:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/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 18:14:09 INFO - Downloaded 1361 bytes. 18:14:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:14:09 INFO - Using the following test package requirements: 18:14:09 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:14:09 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:14:09 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:14:09 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:09 INFO - u'jsshell-linux-x86_64.zip'], 18:14:09 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:14:09 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:14:09 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:14:09 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:14:09 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:14:09 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:09 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:14:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:14:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:14:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:14:09 INFO - Fetch https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:14:09 INFO - Http code: 200 18:14:09 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 18:14:09 INFO - x-amz-cf-id: H6FdW2OQNdpDTAgTp3nzNxT66bxh1XsNKCOU-oAkX5Upr0gKlqfJ1Q== 18:14:09 INFO - x-amz-version-id: yV_3HKSV_7ZWTkSzGmkuonIb23HMf5WB 18:14:10 INFO - Expected file size: 21990087 18:14:10 INFO - Obtained file size: 21990087 18:14:14 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 18:14:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:14:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:14:14 INFO - Fetch https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:14:14 INFO - Http code: 200 18:14:14 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 18:14:14 INFO - x-amz-cf-id: YbPMM5EolUgT2ewnfX_Cvyi3liKIF4l5q1xNHyfhEu6LgA4Sbhaldw== 18:14:14 INFO - x-amz-version-id: yV_3HKSV_7ZWTkSzGmkuonIb23HMf5WB 18:14:15 INFO - Expected file size: 21990087 18:14:15 INFO - Obtained file size: 21990087 18:14:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:14:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:14:19 INFO - Fetch https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:14:20 INFO - Http code: 200 18:14:20 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 18:14:20 INFO - x-amz-cf-id: 80-j_w4ETH97RaCd72_7tjEi03HAqcWID23csWm-nDElkNGf1GHd2g== 18:14:20 INFO - x-amz-version-id: 81R2UycUUEOg2alYhzKXkQsIEUk5BNzZ 18:14:20 INFO - Expected file size: 14408522 18:14:20 INFO - Obtained file size: 14408522 18:14:20 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')]} 18:14:20 INFO - trying https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:14:20 INFO - Downloading https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/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 18:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/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 18:14:21 INFO - Downloaded 59656577 bytes. 18:14:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:14:21 INFO - mkdir: /builds/slave/test/properties 18:14:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:14:21 INFO - Writing to file /builds/slave/test/properties/build_url 18:14:21 INFO - Contents: 18:14:21 INFO - build_url:https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:14:22 INFO - Running post-action listener: _resource_record_post_action 18:14:22 INFO - Running post-action listener: set_extra_try_arguments 18:14:22 INFO - [mozharness: 2016-10-01 01:14:22.508204Z] Finished download-and-extract step (success) 18:14:22 INFO - [mozharness: 2016-10-01 01:14:22.508429Z] Running populate-webroot step. 18:14:22 INFO - Running pre-action listener: _resource_record_pre_action 18:14:22 INFO - Running main action method: populate_webroot 18:14:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:14:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:14:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:14:22 INFO - '--tppagecycles', 18:14:22 INFO - '7'], 18:14:22 INFO - 'tests': ['tsvgm']}}, 18:14:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:14:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:14:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:14:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:14:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:22 INFO - 'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:14:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:14:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:22 INFO - 'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['damp', 'tps']}, 18:14:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:22 INFO - 'tests': ['damp', 'tps']}, 18:14:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['dromaeo_dom']}, 18:14:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:14:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['basic_compositor_video']}, 18:14:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:14:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'other-e10s': {'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['tsvgx', 18:14:22 INFO - 'tsvgr_opacity', 18:14:22 INFO - 'tart', 18:14:22 INFO - 'tscrollx', 18:14:22 INFO - 'cart']}, 18:14:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:14:22 INFO - 'tsvgr_opacity', 18:14:22 INFO - 'tart', 18:14:22 INFO - 'tscrollx', 18:14:22 INFO - 'cart']}, 18:14:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:22 INFO - 'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['tp5o']}, 18:14:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:22 INFO - 'tests': ['tp5o']}, 18:14:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:22 INFO - 'talos_options': ['--disable-e10s', 18:14:22 INFO - '--xperf_path', 18:14:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:14:22 INFO - 'tests': ['tp5n']}, 18:14:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:22 INFO - 'talos_options': ['--xperf_path', 18:14:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:14:22 INFO - 'tests': ['tp5n']}}, 18:14:22 INFO - 'talos.zip': {'path': '', 18:14:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:14:22 INFO - Running post-action listener: _resource_record_post_action 18:14:22 INFO - [mozharness: 2016-10-01 01:14:22.525050Z] Finished populate-webroot step (success) 18:14:22 INFO - [mozharness: 2016-10-01 01:14:22.525138Z] Running create-virtualenv step. 18:14:22 INFO - Running pre-action listener: _resource_record_pre_action 18:14:22 INFO - Running main action method: create_virtualenv 18:14:22 INFO - Creating virtualenv /builds/slave/test/build/venv 18:14:22 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 18:14:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:14:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:14:22 INFO - Using real prefix '/usr' 18:14:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:14:23 INFO - Installing distribute.............................................................................................................................................................................................done. 18:14:25 INFO - Installing pip.................done. 18:14:25 INFO - Return code: 0 18:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:14:25 INFO - Reading from file tmpfile_stdout 18:14:25 INFO - Output received: 18:14:25 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) 18:14:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61e58aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', '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 18:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:14:25 INFO - Using env: {'DISPLAY': ':0', 18:14:25 INFO - 'HOME': '/home/cltbld', 18:14:25 INFO - 'LANG': 'en_US.UTF-8', 18:14:25 INFO - 'LANGUAGE': 'en_US:en', 18:14:25 INFO - 'LOGNAME': 'cltbld', 18:14:25 INFO - 'MAIL': '/var/mail/cltbld', 18:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:25 INFO - 'MOZ_NO_REMOTE': '1', 18:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:25 INFO - 'NO_EM_RESTART': '1', 18:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:25 INFO - 'PWD': '/builds/slave/test', 18:14:25 INFO - 'SHELL': '/bin/bash', 18:14:25 INFO - 'SHLVL': '1', 18:14:25 INFO - 'TERM': 'linux', 18:14:25 INFO - 'TMOUT': '86400', 18:14:25 INFO - 'USER': 'cltbld', 18:14:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:25 INFO - '_': '/tools/buildbot/bin/python'} 18:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:25 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 18:14:25 INFO - Cleaning up... 18:14:25 INFO - Return code: 0 18:14:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f61e58aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', '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 18:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:14:25 INFO - Using env: {'DISPLAY': ':0', 18:14:25 INFO - 'HOME': '/home/cltbld', 18:14:25 INFO - 'LANG': 'en_US.UTF-8', 18:14:25 INFO - 'LANGUAGE': 'en_US:en', 18:14:25 INFO - 'LOGNAME': 'cltbld', 18:14:25 INFO - 'MAIL': '/var/mail/cltbld', 18:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:25 INFO - 'MOZ_NO_REMOTE': '1', 18:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:25 INFO - 'NO_EM_RESTART': '1', 18:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:25 INFO - 'PWD': '/builds/slave/test', 18:14:25 INFO - 'SHELL': '/bin/bash', 18:14:25 INFO - 'SHLVL': '1', 18:14:25 INFO - 'TERM': 'linux', 18:14:25 INFO - 'TMOUT': '86400', 18:14:25 INFO - 'USER': 'cltbld', 18:14:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:25 INFO - '_': '/tools/buildbot/bin/python'} 18:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:25 INFO - Downloading/unpacking psutil>=3.1.1 18:14:25 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 18:14:25 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 18:14:25 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 18:14:25 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 18:14:25 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 18:14:25 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 18:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:14:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:27 INFO - Installing collected packages: psutil 18:14:27 INFO - Running setup.py install for psutil 18:14:27 INFO - building 'psutil._psutil_linux' extension 18:14:27 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 18:14:28 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 18:14:28 INFO - building 'psutil._psutil_posix' extension 18:14:28 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 18:14:28 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 18:14:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:28 INFO - Successfully installed psutil 18:14:28 INFO - Cleaning up... 18:14:28 INFO - Return code: 0 18:14:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:14:28 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')]} 18:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:28 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')]} 18:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:28 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 0x7f61e58aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', '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 18:14:28 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 18:14:28 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 18:14:28 INFO - Using env: {'DISPLAY': ':0', 18:14:28 INFO - 'HOME': '/home/cltbld', 18:14:28 INFO - 'LANG': 'en_US.UTF-8', 18:14:28 INFO - 'LANGUAGE': 'en_US:en', 18:14:28 INFO - 'LOGNAME': 'cltbld', 18:14:28 INFO - 'MAIL': '/var/mail/cltbld', 18:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:28 INFO - 'MOZ_NO_REMOTE': '1', 18:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:28 INFO - 'NO_EM_RESTART': '1', 18:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:28 INFO - 'PWD': '/builds/slave/test', 18:14:28 INFO - 'SHELL': '/bin/bash', 18:14:28 INFO - 'SHLVL': '1', 18:14:28 INFO - 'TERM': 'linux', 18:14:28 INFO - 'TMOUT': '86400', 18:14:28 INFO - 'USER': 'cltbld', 18:14:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:28 INFO - '_': '/tools/buildbot/bin/python'} 18:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:14:30 INFO - Installing collected packages: mozsystemmonitor 18:14:30 INFO - Running setup.py install for mozsystemmonitor 18:14:30 INFO - Successfully installed mozsystemmonitor 18:14:30 INFO - Cleaning up... 18:14:30 INFO - Return code: 0 18:14:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f61e58aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', '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 18:14:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:14:30 INFO - Using env: {'DISPLAY': ':0', 18:14:30 INFO - 'HOME': '/home/cltbld', 18:14:30 INFO - 'LANG': 'en_US.UTF-8', 18:14:30 INFO - 'LANGUAGE': 'en_US:en', 18:14:30 INFO - 'LOGNAME': 'cltbld', 18:14:30 INFO - 'MAIL': '/var/mail/cltbld', 18:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:30 INFO - 'MOZ_NO_REMOTE': '1', 18:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:30 INFO - 'NO_EM_RESTART': '1', 18:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:30 INFO - 'PWD': '/builds/slave/test', 18:14:30 INFO - 'SHELL': '/bin/bash', 18:14:30 INFO - 'SHLVL': '1', 18:14:30 INFO - 'TERM': 'linux', 18:14:30 INFO - 'TMOUT': '86400', 18:14:30 INFO - 'USER': 'cltbld', 18:14:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:30 INFO - '_': '/tools/buildbot/bin/python'} 18:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:30 INFO - Downloading/unpacking jsonschema==2.5.1 18:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:14:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14:33 INFO - Downloading functools32-3.2.3-2.tar.gz 18:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:14:33 INFO - warning: no files found matching '*.txt' 18:14:33 INFO - no previously-included directories found matching 'build' 18:14:33 INFO - no previously-included directories found matching 'dist' 18:14:33 INFO - no previously-included directories found matching '.git*' 18:14:33 INFO - Installing collected packages: jsonschema, functools32 18:14:33 INFO - Running setup.py install for functools32 18:14:33 INFO - warning: no files found matching '*.txt' 18:14:33 INFO - no previously-included directories found matching 'build' 18:14:33 INFO - no previously-included directories found matching 'dist' 18:14:33 INFO - no previously-included directories found matching '.git*' 18:14:33 INFO - Successfully installed jsonschema functools32 18:14:33 INFO - Cleaning up... 18:14:33 INFO - Return code: 0 18:14:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f61e58aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', '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 18:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:14:33 INFO - Using env: {'DISPLAY': ':0', 18:14:33 INFO - 'HOME': '/home/cltbld', 18:14:33 INFO - 'LANG': 'en_US.UTF-8', 18:14:33 INFO - 'LANGUAGE': 'en_US:en', 18:14:33 INFO - 'LOGNAME': 'cltbld', 18:14:33 INFO - 'MAIL': '/var/mail/cltbld', 18:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:33 INFO - 'MOZ_NO_REMOTE': '1', 18:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:33 INFO - 'NO_EM_RESTART': '1', 18:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:33 INFO - 'PWD': '/builds/slave/test', 18:14:33 INFO - 'SHELL': '/bin/bash', 18:14:33 INFO - 'SHLVL': '1', 18:14:33 INFO - 'TERM': 'linux', 18:14:33 INFO - 'TMOUT': '86400', 18:14:33 INFO - 'USER': 'cltbld', 18:14:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:33 INFO - '_': '/tools/buildbot/bin/python'} 18:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:14:33 INFO - Cleaning up... 18:14:33 INFO - Return code: 0 18:14:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f61e58aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', '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 18:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:14:33 INFO - Using env: {'DISPLAY': ':0', 18:14:33 INFO - 'HOME': '/home/cltbld', 18:14:33 INFO - 'LANG': 'en_US.UTF-8', 18:14:33 INFO - 'LANGUAGE': 'en_US:en', 18:14:33 INFO - 'LOGNAME': 'cltbld', 18:14:33 INFO - 'MAIL': '/var/mail/cltbld', 18:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:33 INFO - 'MOZ_NO_REMOTE': '1', 18:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:33 INFO - 'NO_EM_RESTART': '1', 18:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:33 INFO - 'PWD': '/builds/slave/test', 18:14:33 INFO - 'SHELL': '/bin/bash', 18:14:33 INFO - 'SHLVL': '1', 18:14:33 INFO - 'TERM': 'linux', 18:14:33 INFO - 'TMOUT': '86400', 18:14:33 INFO - 'USER': 'cltbld', 18:14:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:33 INFO - '_': '/tools/buildbot/bin/python'} 18:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:33 INFO - Downloading/unpacking blobuploader==1.2.4 18:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:35 INFO - Downloading blobuploader-1.2.4.tar.gz 18:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:14:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:14:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:36 INFO - Downloading docopt-0.6.1.tar.gz 18:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:14:36 INFO - Installing collected packages: blobuploader, requests, docopt 18:14:36 INFO - Running setup.py install for blobuploader 18:14:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:14:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:14:36 INFO - Running setup.py install for requests 18:14:37 INFO - Running setup.py install for docopt 18:14:37 INFO - Successfully installed blobuploader requests docopt 18:14:37 INFO - Cleaning up... 18:14:37 INFO - Return code: 0 18:14:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:37 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')]} 18:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:37 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')]} 18:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:37 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 0x7f61e58aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', '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 18:14:37 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 18:14:37 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 18:14:37 INFO - Using env: {'DISPLAY': ':0', 18:14:37 INFO - 'HOME': '/home/cltbld', 18:14:37 INFO - 'LANG': 'en_US.UTF-8', 18:14:37 INFO - 'LANGUAGE': 'en_US:en', 18:14:37 INFO - 'LOGNAME': 'cltbld', 18:14:37 INFO - 'MAIL': '/var/mail/cltbld', 18:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:37 INFO - 'MOZ_NO_REMOTE': '1', 18:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:37 INFO - 'NO_EM_RESTART': '1', 18:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:37 INFO - 'PWD': '/builds/slave/test', 18:14:37 INFO - 'SHELL': '/bin/bash', 18:14:37 INFO - 'SHLVL': '1', 18:14:37 INFO - 'TERM': 'linux', 18:14:37 INFO - 'TMOUT': '86400', 18:14:37 INFO - 'USER': 'cltbld', 18:14:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:37 INFO - '_': '/tools/buildbot/bin/python'} 18:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:14:37 INFO - Running setup.py (path:/tmp/pip-tZOERv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:14:37 INFO - Running setup.py (path:/tmp/pip-fPBkgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:14:37 INFO - Running setup.py (path:/tmp/pip-2L90O_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:14:37 INFO - Running setup.py (path:/tmp/pip-Acd_xR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:14:37 INFO - Running setup.py (path:/tmp/pip-vg9TaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:14:37 INFO - Running setup.py (path:/tmp/pip-yLgWII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:14:37 INFO - Running setup.py (path:/tmp/pip-gG8sMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:14:37 INFO - Running setup.py (path:/tmp/pip-BSqE9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:14:38 INFO - Running setup.py (path:/tmp/pip-jDqpxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:14:38 INFO - Running setup.py (path:/tmp/pip-PBMjCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:14:38 INFO - Running setup.py (path:/tmp/pip-jsfo3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:14:38 INFO - Running setup.py (path:/tmp/pip-31eJ1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:14:38 INFO - Running setup.py (path:/tmp/pip-as3Qip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:14:38 INFO - Running setup.py (path:/tmp/pip-SyK0HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:38 INFO - Running setup.py (path:/tmp/pip-DLYqsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:14:38 INFO - Running setup.py (path:/tmp/pip-smscsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:14:38 INFO - Running setup.py (path:/tmp/pip-LxbIcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:14:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:14:38 INFO - Running setup.py install for manifestparser 18:14:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:14:38 INFO - Running setup.py install for mozcrash 18:14:38 INFO - Running setup.py install for mozdebug 18:14:38 INFO - Running setup.py install for mozdevice 18:14:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Running setup.py install for mozfile 18:14:39 INFO - Running setup.py install for mozhttpd 18:14:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Running setup.py install for mozinfo 18:14:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Running setup.py install for mozInstall 18:14:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Running setup.py install for mozleak 18:14:39 INFO - Running setup.py install for mozlog 18:14:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Running setup.py install for moznetwork 18:14:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:14:39 INFO - Running setup.py install for mozprocess 18:14:39 INFO - Running setup.py install for mozprofile 18:14:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Running setup.py install for mozrunner 18:14:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Running setup.py install for mozscreenshot 18:14:40 INFO - Running setup.py install for moztest 18:14:40 INFO - Running setup.py install for mozversion 18:14:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:14:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:14:40 INFO - Cleaning up... 18:14:40 INFO - Return code: 0 18:14:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:40 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 0x7f61e58aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', '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 18:14:40 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 18:14:40 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 18:14:40 INFO - Using env: {'DISPLAY': ':0', 18:14:40 INFO - 'HOME': '/home/cltbld', 18:14:40 INFO - 'LANG': 'en_US.UTF-8', 18:14:40 INFO - 'LANGUAGE': 'en_US:en', 18:14:40 INFO - 'LOGNAME': 'cltbld', 18:14:40 INFO - 'MAIL': '/var/mail/cltbld', 18:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:40 INFO - 'MOZ_NO_REMOTE': '1', 18:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:40 INFO - 'NO_EM_RESTART': '1', 18:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:40 INFO - 'PWD': '/builds/slave/test', 18:14:40 INFO - 'SHELL': '/bin/bash', 18:14:40 INFO - 'SHLVL': '1', 18:14:40 INFO - 'TERM': 'linux', 18:14:40 INFO - 'TMOUT': '86400', 18:14:40 INFO - 'USER': 'cltbld', 18:14:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:40 INFO - '_': '/tools/buildbot/bin/python'} 18:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:14:40 INFO - Running setup.py (path:/tmp/pip-A_1_tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:14:40 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)) 18:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:14:40 INFO - Running setup.py (path:/tmp/pip-xLEWgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:14:40 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)) 18:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:14:40 INFO - Running setup.py (path:/tmp/pip-adxjWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:14:40 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)) 18:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:14:40 INFO - Running setup.py (path:/tmp/pip-tqyS0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:14:41 INFO - Running setup.py (path:/tmp/pip-fENpVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:14:41 INFO - Running setup.py (path:/tmp/pip-LUbYOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:14:41 INFO - Running setup.py (path:/tmp/pip-XBF5xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:14:41 INFO - Running setup.py (path:/tmp/pip-Ohl1ME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:14:41 INFO - Running setup.py (path:/tmp/pip-P06mgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:14:41 INFO - Running setup.py (path:/tmp/pip-3Xi3Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:14:41 INFO - Running setup.py (path:/tmp/pip-algItN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:14:41 INFO - Running setup.py (path:/tmp/pip-E7efPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:14:41 INFO - Running setup.py (path:/tmp/pip-IpwUFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:14:41 INFO - Running setup.py (path:/tmp/pip-cNTkfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:41 INFO - Running setup.py (path:/tmp/pip-tkkczF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:14:41 INFO - Running setup.py (path:/tmp/pip-hBS41l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:14:41 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)) 18:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:14:41 INFO - Running setup.py (path:/tmp/pip-kuBOaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:14:41 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)) 18:14:41 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)) 18:14:41 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)) 18:14:41 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)) 18:14:41 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)) 18:14:41 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)) 18:14:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:14:42 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 18:14:42 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 18:14:42 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 18:14:42 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 18:14:42 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 18:14:42 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 18:14:43 INFO - Downloading blessings-1.6.tar.gz 18:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:14:43 INFO - Installing collected packages: blessings 18:14:43 INFO - Running setup.py install for blessings 18:14:44 INFO - Successfully installed blessings 18:14:44 INFO - Cleaning up... 18:14:44 INFO - Return code: 0 18:14:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:14:44 INFO - Reading from file tmpfile_stdout 18:14:44 INFO - Current package versions: 18:14:44 INFO - argparse == 1.2.1 18:14:44 INFO - blessings == 1.6 18:14:44 INFO - blobuploader == 1.2.4 18:14:44 INFO - docopt == 0.6.1 18:14:44 INFO - functools32 == 3.2.3-2 18:14:44 INFO - jsonschema == 2.5.1 18:14:44 INFO - manifestparser == 1.1 18:14:44 INFO - mozInstall == 1.12 18:14:44 INFO - mozcrash == 0.17 18:14:44 INFO - mozdebug == 0.1 18:14:44 INFO - mozdevice == 0.48 18:14:44 INFO - mozfile == 1.2 18:14:44 INFO - mozhttpd == 0.7 18:14:44 INFO - mozinfo == 0.9 18:14:44 INFO - mozleak == 0.1 18:14:44 INFO - mozlog == 3.4 18:14:44 INFO - moznetwork == 0.27 18:14:44 INFO - mozprocess == 0.23 18:14:44 INFO - mozprofile == 0.28 18:14:44 INFO - mozrunner == 6.12 18:14:44 INFO - mozscreenshot == 0.1 18:14:44 INFO - mozsystemmonitor == 0.3 18:14:44 INFO - moztest == 0.7 18:14:44 INFO - mozversion == 1.4 18:14:44 INFO - psutil == 3.1.1 18:14:44 INFO - requests == 1.2.3 18:14:44 INFO - wsgiref == 0.1.2 18:14:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:44 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')]} 18:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:44 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')]} 18:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:44 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 0x7f61e58aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', '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 18:14:44 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 18:14:44 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 18:14:44 INFO - Using env: {'DISPLAY': ':0', 18:14:44 INFO - 'HOME': '/home/cltbld', 18:14:44 INFO - 'LANG': 'en_US.UTF-8', 18:14:44 INFO - 'LANGUAGE': 'en_US:en', 18:14:44 INFO - 'LOGNAME': 'cltbld', 18:14:44 INFO - 'MAIL': '/var/mail/cltbld', 18:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:44 INFO - 'MOZ_NO_REMOTE': '1', 18:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:44 INFO - 'NO_EM_RESTART': '1', 18:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:44 INFO - 'PWD': '/builds/slave/test', 18:14:44 INFO - 'SHELL': '/bin/bash', 18:14:44 INFO - 'SHLVL': '1', 18:14:44 INFO - 'TERM': 'linux', 18:14:44 INFO - 'TMOUT': '86400', 18:14:44 INFO - 'USER': 'cltbld', 18:14:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:44 INFO - '_': '/tools/buildbot/bin/python'} 18:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:44 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)) 18:14:44 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)) 18:14:44 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)) 18:14:44 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)) 18:14:44 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)) 18:14:44 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)) 18:14:44 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)) 18:14:44 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)) 18:14:44 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)) 18:14:44 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)) 18:14:44 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)) 18:14:44 INFO - Cleaning up... 18:14:44 INFO - Return code: 0 18:14:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:14:44 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')]} 18:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:44 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')]} 18:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:44 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 0x7f61e58aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', '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 18:14:44 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 18:14:44 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 18:14:44 INFO - Using env: {'DISPLAY': ':0', 18:14:44 INFO - 'HOME': '/home/cltbld', 18:14:44 INFO - 'LANG': 'en_US.UTF-8', 18:14:44 INFO - 'LANGUAGE': 'en_US:en', 18:14:44 INFO - 'LOGNAME': 'cltbld', 18:14:44 INFO - 'MAIL': '/var/mail/cltbld', 18:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:44 INFO - 'MOZ_NO_REMOTE': '1', 18:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:44 INFO - 'NO_EM_RESTART': '1', 18:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:44 INFO - 'PWD': '/builds/slave/test', 18:14:44 INFO - 'SHELL': '/bin/bash', 18:14:44 INFO - 'SHLVL': '1', 18:14:44 INFO - 'TERM': 'linux', 18:14:44 INFO - 'TMOUT': '86400', 18:14:44 INFO - 'USER': 'cltbld', 18:14:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:44 INFO - '_': '/tools/buildbot/bin/python'} 18:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:14:44 INFO - Cleaning up... 18:14:44 INFO - Return code: 0 18:14:44 INFO - Running post-action listener: _resource_record_post_action 18:14:44 INFO - Running post-action listener: _start_resource_monitoring 18:14:44 INFO - Starting resource monitoring. 18:14:44 INFO - [mozharness: 2016-10-01 01:14:44.896986Z] Finished create-virtualenv step (success) 18:14:44 INFO - [mozharness: 2016-10-01 01:14:44.897514Z] Running install step. 18:14:44 INFO - Running pre-action listener: _resource_record_pre_action 18:14:44 INFO - Running main action method: install 18:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:14:45 INFO - Reading from file tmpfile_stdout 18:14:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:14:45 INFO - Reading from file tmpfile_stdout 18:14:45 INFO - Output received: 18:14:45 INFO - Usage: mozinstall [options] installer 18:14:45 INFO - Options: 18:14:45 INFO - -h, --help show this help message and exit 18:14:45 INFO - -d DEST, --destination=DEST 18:14:45 INFO - Directory to install application into. [default: 18:14:45 INFO - "/builds/slave/test"] 18:14:45 INFO - --app=APP Application being installed. [default: firefox] 18:14:45 INFO - mkdir: /builds/slave/test/build/application 18:14:45 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'] 18:14:45 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 18:15:02 INFO - Reading from file tmpfile_stdout 18:15:02 INFO - Output received: 18:15:02 INFO - /builds/slave/test/build/application/firefox/firefox 18:15:02 INFO - Running post-action listener: _resource_record_post_action 18:15:02 INFO - [mozharness: 2016-10-01 01:15:02.202664Z] Finished install step (success) 18:15:02 INFO - [mozharness: 2016-10-01 01:15:02.202908Z] Running run-tests step. 18:15:02 INFO - Running pre-action listener: _resource_record_pre_action 18:15:02 INFO - Running main action method: run_tests 18:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:15:02 INFO - Python 2.7.3 18:15:02 INFO - Return code: 0 18:15:02 INFO - grabbing minidump binary from tooltool 18:15:02 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')]} 18:15:02 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 0x28bc930>, '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 0x28bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28bdcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:15:02 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 18:15:02 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 18:15:02 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 18:15:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:15:02 INFO - Return code: 0 18:15:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:15:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:15:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:15:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:15:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:15:02 INFO - Using env: {'DISPLAY': ':0', 18:15:02 INFO - 'HOME': '/home/cltbld', 18:15:02 INFO - 'LANG': 'en_US.UTF-8', 18:15:02 INFO - 'LANGUAGE': 'en_US:en', 18:15:02 INFO - 'LOGNAME': 'cltbld', 18:15:02 INFO - 'MAIL': '/var/mail/cltbld', 18:15:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:15:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:02 INFO - 'MOZ_NO_REMOTE': '1', 18:15:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:02 INFO - 'NO_EM_RESTART': '1', 18:15:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:02 INFO - 'PWD': '/builds/slave/test', 18:15:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:15:02 INFO - 'SHELL': '/bin/bash', 18:15:02 INFO - 'SHLVL': '1', 18:15:02 INFO - 'TERM': 'linux', 18:15:02 INFO - 'TMOUT': '86400', 18:15:02 INFO - 'USER': 'cltbld', 18:15:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281', 18:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:02 INFO - '_': '/tools/buildbot/bin/python'} 18:15:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:15:02 INFO - mozversion application_buildid: 20160930153004 18:15:02 INFO - mozversion application_changeset: d69d58af9bea7a2781304d3ee3ba2122b2c07abf 18:15:02 INFO - mozversion application_display_name: Nightly 18:15:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:15:02 INFO - mozversion application_name: Firefox 18:15:02 INFO - mozversion application_remotingname: firefox 18:15:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:15:02 INFO - mozversion application_vendor: Mozilla 18:15:02 INFO - mozversion application_version: 52.0a1 18:15:02 INFO - mozversion platform_buildid: 20160930153004 18:15:02 INFO - mozversion platform_changeset: d69d58af9bea7a2781304d3ee3ba2122b2c07abf 18:15:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:15:02 INFO - mozversion platform_version: 52.0a1 18:15:02 INFO - using testdate: 1475284502 18:15:02 INFO - actual date: 1475284502 18:15:02 INFO - starting webserver on 'localhost:46590' 18:15:02 INFO - SUITE-START | Running 2 tests 18:15:02 INFO - TEST-START | dromaeo_css 18:15:02 INFO - operating with platform_type : linux_ 18:15:02 INFO - Initialising browser for dromaeo_css test... 18:15:02 INFO - TEST-INFO | started process 25855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeP8NJQ/profile http://localhost:46590/getInfo.html) 18:15:07 INFO - PROCESS | 25855 | __metrics Screen width/height:1600/1200 18:15:07 INFO - PROCESS | 25855 | colorDepth:24 18:15:07 INFO - PROCESS | 25855 | Browser inner width/height: 1024/697 18:15:07 INFO - PROCESS | 25855 | __metrics 18:15:08 ERROR - PROCESS | 25855 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 18:15:09 INFO - TEST-INFO | 25855: exit 0 18:15:09 INFO - Browser initialized. 18:15:09 INFO - Running cycle 1/1 for dromaeo_css test... 18:15:09 INFO - TEST-INFO | started process 25975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeP8NJQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:21 INFO - PROCESS | 25975 | RSS: Main: 185020416 18:15:21 INFO - PROCESS | 25975 | 18:16:11 INFO - PROCESS | 25975 | 1475284571066 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] 18:18:20 INFO - PROCESS | 25975 | Cycle 1(1): loaded http://localhost:46590/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46590/tests/dromaeo/cssquery-ext.html) 18:18:21 INFO - PROCESS | 25975 | RSS: Main: 202420224 18:18:21 INFO - PROCESS | 25975 | 18:21:24 INFO - PROCESS | 25975 | Cycle 1(1): loaded http://localhost:46590/tests/dromaeo/cssquery-ext.html (next: http://localhost:46590/tests/dromaeo/cssquery-jquery.html) 18:21:24 INFO - PROCESS | 25975 | RSS: Main: 200884224 18:21:24 INFO - PROCESS | 25975 | 18:24:26 INFO - PROCESS | 25975 | Cycle 1(1): loaded http://localhost:46590/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46590/tests/dromaeo/cssquery-mootools.html) 18:24:27 INFO - PROCESS | 25975 | RSS: Main: 199249920 18:24:27 INFO - PROCESS | 25975 | 18:27:29 INFO - PROCESS | 25975 | Cycle 1(1): loaded http://localhost:46590/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46590/tests/dromaeo/cssquery-prototype.html) 18:27:29 INFO - PROCESS | 25975 | RSS: Main: 195432448 18:27:29 INFO - PROCESS | 25975 | 18:30:32 INFO - PROCESS | 25975 | Cycle 1(1): loaded http://localhost:46590/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46590/tests/dromaeo/cssquery-yui.html) 18:30:32 INFO - PROCESS | 25975 | RSS: Main: 198819840 18:30:32 INFO - PROCESS | 25975 | 18:33:35 INFO - PROCESS | 25975 | Cycle 1(1): loaded http://localhost:46590/tests/dromaeo/cssquery-yui.html (next: http://localhost:46590/tests/dromaeo/cssquery-dojo.html) 18:33:35 INFO - PROCESS | 25975 | RSS: Main: 199544832 18:33:35 INFO - PROCESS | 25975 | 18:33:35 INFO - PROCESS | 25975 | __start_tp_report 18:33:35 INFO - PROCESS | 25975 | _x_x_mozilla_page_load 18:33:35 INFO - PROCESS | 25975 | _x_x_mozilla_page_load_details 18:33:35 INFO - PROCESS | 25975 | |i|pagename|runs| 18:33:35 INFO - PROCESS | 25975 | |0;dojo.html;2969.2576855786056;2975.4941659917813;2999.340145168064;3004.4591973444785;3023.7732170087247;5252.264682944391;5278.261043453919;5329.120695085307;5338.0658384782655;5347.385050719168;5347.812826551071;5381.919271210935;5387.380451248107;5426.430224826396;5464.726763661811;4876.97561512192;4960.23116416956;4970.975145124269;5016.673916195454;5021.698698078127;4911.68074075184;4978.775955082012;5005.499450054984;5011.599072074226;5015.974920125394;4734.644901632374;4790.449098353699;4798.64010199233;4807.254875494304;4924.75376231187;4816.349792778;4846.0550192712435;4872.756362181912;4887.560119589219;4889.29105279736;4768.451628062748;4804.615630749532;4821.54195351441;4847.297141914402;4859.538343857328;5095.745212739348;5178.40448348441;5252.844374237661;5287.524122828964;5366.221897824833;5696.174054762037;5702.7433765480655;5717.9714101429645;5722.828315150552;5771.971140144315;5730.68481233532;5730.7421166047625;5742.052561327376;5751.712414379306;5753.453421924911;5238.161894096965;5318.069337865935;5334.946650533522;5371.785128594852;5378.865528361783;5872.706364681749;5911.615744976649;5919.253820123074;5972.223610930551;5984.192134061933;5649.745761440663;5665.065264231438;5676.971615141898;5679.971600141973;5690.658560486384;5590.133529302964;5625.38120806711;5705.22979397776;5755.59710820247;5792.391798861143;5637.238972738628;5668.036433806263;5676.801311954062;5680.403557626472;5718.714064296852;5670.631408958405;5672.347680016851;5675.1770993205755;5678.914816277759;5680.517156041783;4399.186150562156;4401.603855653007;4416.514183439819;4419.668524860584;4469.865904022885;3901.3562762144497;3909.3354129798004;3914.432407300925;3974;3982.283189026003;5448.210009548593;5470.316210473691;5472.370677372153;5483.479069488392;5488.259085023471;5616.438356164351;5711.200431939532;5724.25584673998;5747.971260143756;5770.913436298459;5481.561475081984;5496.560275177976;5499;5499.587530935196;5557.777688892399;4959.62802789785;5017.89964200714;5018.548330650186;5023.748812559431;5074.67014644047;5796.043652797325;5853.180554722342;5905.320888097924;5969.850753731104;5977.701114944322;5777.480026797609;5787.855303617275;5798.739056742541;5857.765689372548;5866.41335866427;5958.910616340845;6000.459958603747;6007.339192688888;6008.429199226067;6023.518118550418;5538.418466061166;5563.082091454865;5635.211070450058;5659.434056594472;5668.206451096932;5670.489655930986;5719.599628025998;5783.566232532661;5806.622569532967;5814.505767009851;5527.391986881359;5542.307211598551;5547.44525547442;5548.140038294071;5589.329280486368;5467.7266136692215;5585.776568937197;5594.440555944373;5597.44025597437;5598.244237028112;5443.918341224806;5465.289512363367;5518.117101263779;5530.11518157109;5556.749946252509;5537.501624853782;5628.493435590653;5632.183333416713;5632.943670563406;5635.0702134147405;5395.244665746877;5487.259220005249;5519.8896022080135;5523.005858945428;5556.027695153412 18:33:35 INFO - PROCESS | 25975 | |1;ext.html;525.6583220906408;577.5783677915122;581.276310992814;591.7603370634895;593.6467801658014;30292;34094.147646308855;34172.829135854314;40010.799946000305;41019.38470922939;42414.78792606033;42768.14463710724;42805.57194428055;42870.35694464586;42889.78555107228;8736.170063843925;8882.86675699865;8884.244839188645;8895.421797583136;8897.822043559125;8785.253253473462;8853.513056781874;8855.24730397917;8876.156765107304;8883.555822208897;8771.824563508726;8814.735557933273;8818.603162857687;8831.161039701217;8842.955785221096;8731.214190722834;8772.473651580925;8774.429662071945;8796.912030879705;8832.33757468186;8584.914150858474;8590.312774977987;8651.178138076935;8673.82652346956;8677.913220867773;39865.40201896974;40109.79945100285;40192.39711404331;40346.79826600877;40376.39435408471;3334.216459132102;3476.1135910342955;3573.4639804029343;3807.295650304675;3814.0083578269573;29921;30426.39147217043;30457.847710761303;30482;31451;3709.51776269086;3793.7723736575895;3813.0848596336677;3888.319544079775;3978.1645854370618;296188;297791.5552111193;297871.51064244757;298349;299831;52157;52929;52954.735226323624;53030;53204.73397632987;34961.82519087388;35398.82300588532;35452.64547354545;36917;36981.44527832085;14974.727148192525;15112.697746045238;15152.090874547563;15158.696826063637;15177.696446071017;11370.260933039326;11392.886071139348;11420.94289528547;11436.714082148013;11447.656570302905;17675.20461579232;17887;17894.642107157782;17925.820741792417;17935;6782.423494002966;6798.728050878009;6858.3827455529245;6897.517173797886;7039.753608623673;945.7493764152505;1016.7153197104675;1101.7190616392768;1103.5530610102921;1150.5800382860195;30615.234619134255;30827;30838.75741124014;31236.843815780776;31270.218244544067;1019.8572199892021;1023.2581378500528;1073.2326386633595;1074.7904158689137;1096.221682605359;15703.371865125268;15960.920195399181;16031.43889963869;16200.51398458048;16350.264238109075;499722;499733;504730;507237;507621;54054.459455405726;54894;55070;55077.44922550803;55202;1247.0460098025019;1315.7105436803888;1320.5312114199512;1321.861204573506;1331.134762404445;28866.855665722378;30211.395772084874;30751.38497229998;30917.536236956013;31075.533866992464;46308.07383852371;46488.302675460574;46667;46934.765326173154;46976.29535557038;412480;415299;415936.44222452067;416138;416533;26811.597826032234;27064.1880743578;27187.456250875268;27589.72410275952;27695.584566231926;44260.33609495796;44400.78976292234;44796.77601611971;45184.77407612941;46037.07925841397;35545.289094217456;36217.27565448729;36371;36643.81678091593;37356;38277.42583861189;38395.80802095972;38903.41644875386;39230.80384598059;39301.2139757209;38271.23457530778;38533.22933541369;38564.421533676454;38998;39867;32715.672843272216;35272;35662;35769.642303576635;36190.45714314235;27560;27751.30621734392;27793.305167370978;27859.303517412227;28075.859620701765 18:33:35 INFO - PROCESS | 25975 | |2;jquery.html;386.94776205212287;389.8752399232245;400.85569195089766;401.50213734968645;416.5272415808059;16034.59913502163;16541.91729041356;17681.29274829007;19167.520811979706;19283.22867085317;11830.408479576008;12051.216670916385;12519.749605007893;12797.616071517847;18599.442016739486;5107.616928730342;5319.9202011969855;5377.381601115863;5378;5384.515393614574;4586.793594288249;5218.347706536683;5774.711264436783;5810.5932584719085;5831.650100993933;5741.196232527429;5768;5784.82645520635;5788;5797.3043234811885;5559.555235581164;5678.346990096151;5699.173619825144;5715.171300161495;5744.368119506872;4952.950470495321;5110.437851836295;5121.078205922932;5137.023965446553;5143.794248230066;13436.126651767701;14893.32980015902;22021.119155233773;22448.887755561118;22553.548929021326;2154.289084602093;2307.723073231223;2436.9390765230833;2611.190530935416;2625.671791026122;10069.244806639457;10121.544530496072;10613.893861061444;11039.503222355013;14330.64173395663;1855.1837191635773;1906.8474522038205;1920.711893216015;1935.796741342153;1946.3285166617495;82147;83059.58470207671;83442.16557834405;83672.58163709204;84000;9947.602095916227;9995.80008399828;10059.748506287255;10069.979006298081;10176.542055607515;13666.863331366758;13686.178829270275;13704.65738356529;13722.65693357674;13755.38100785467;7177.569345839266;7404.925950740531;7446.329830315298;7634.274743899321;7660.885086723703;7129.964350178216;7188;7195;7363.7422690205585;7469.477136600386;4187.497500299984;4226.112516371535;4281.785910704452;4374.58441448062;4633.907321853544;1796.4341232511717;1830.2587452081927;1849.6431908084373;1849.9188413035336;1858.4145994012113;929.5027160469117;1042.3120740311358;1045.1847558904067;1071.2661826648614;1078.4607696151925;17646.647067058842;17787.911060444614;18650.81349186491;18841.52896177579;19500.1224944875;1007.9193664506969;1020.6121673763922;1064.2231171245035;1064.4837253931837;1075.456894268405;10051.195904327782;10689.679309620724;10696.732581685364;10755.462226888782;10758.838617420744;397609;405433;405478;405683;406473;85106.57446712727;90294.54852725695;90760.54619726991;91127;91605;981.9558119884622;1002.7593377589326;1006.0643601450574;1006.8036732837027;1012.3622118065572;16129.516114516584;16527;16605.50183494497;17114.828851711325;17343.479695609152;39480.2103957925;40641.39037914375;40769.79615101906;41394.172116558104;41907.16185676208;51878.74060629673;53491.465085348646;54381.45618543922;56232.718836405555;56708.43291567032;8118.472299300526;8266.809295536808;8300.667973281;8494.532800695773;8590;11738.823917641414;12805.295708736108;12922.676933076747;13109.672258193621;13150.473981040652;10801.351918884891;10861.78276434451;11137.220394572627;11303.7739245213;12044;11113.333200008025;11447.656570302905;11546.711332216426;11577.884221157681;11599.420028998686;11354.148438866952;11398.145139114766;11430.142739294752;11844;11845.822312665145;8396.87404688918;8426.873596895928;8480.363972701949;8531.8720219198;8818.823623527622;11324.830127547928;11326.263792853439;11669.76660466769;11915.76168476643;12146 18:33:35 INFO - PROCESS | 25975 | |3;mootools.html;1476.070075852213;1500.8799296056316;1633.175246500517;1684.8989060656354;1737.5569229846394;7957.681692732283;8193.631286592103;8626.74119776407;9274.489903055337;9279.860802087975;8755.3871229014;9033.187013168814;9037.63849446023;9164.633414663422;9182;2323.6398358254455;2331.463763334434;2344.3787396339985;2351.7530659280787;2359.2568340972625;2242.383344580245;2275.931722048333;2341.203990643181;2346.6128088865316;2348.812095032402;2273.943151421211;2295.8163346932206;2299.448132448217;2319.895604697793;2325.360525855386;2241.9215327463544;2243.4839986803127;2257.762934891829;2259.604569200383;2260.525289689167;2200.834937379687;2213.18112298449;2219.0125394199586;2225.0765932138142;2227.354067320475;8834.072422395684;9186.219171370441;9250.768730781718;9277.257819374434;9320.813583728355;5089.949100509021;5186.688798672054;5191.117510023305;5228.5555727763185;5247.39654939683;3241.546183534307;3275.8034517929;3399.55805745254;3434.6050204226585;3444.2422667013216;1065.749548856026;1073.5652060915343;1083.4420273559124;1098.1434481104752;1104.1111904916538;12797.616071517868;12894.355282235945;12910.483580656763;12918.741625167539;12951.805722914163;4397.450318710161;4465.933011004838;4649.395578574764;4691.413573303337;4694.718316900997;10594.57621695139;10726.73183170427;10757;10766.300190487593;10767.946160269148;5129.435762066169;5135.948640513622;5141.691498510101;5159.045576568347;5205.037068142406;4066;4159.856039589137;4541.545845415498;4670.1126785910565;4705.129551033001;3773.8301776420126;3893;3976.58245884178;3976.681865450757;4053.3312003519677;1258.8363512743285;1265.9303738294482;1302.9348532573333;1304.8108024336418;1309.6987692830703;843.5402705525503;985.4087547471603;986.1765425869336;988.9901100989042;1011.5195282240877;5923.49650279731;6100.389961003864;6134.8159555213415;6150.138980542728;6174.38256174379;392.4270564975111;397.7871838566353;398.4959026831061;403.7759043730758;416.35465029204613;3872.8257228424786;3925.784081875467;3942.802859856996;3959.762414255154;3968.444417781513;10898.618548350929;11113.444327783578;11220.887791122148;11306.152038597138;11316;11108.722281942855;11202.607908723156;11207.159463040305;11254.38100904458;11270.267432616854;8414.579271036546;8428.283595894418;8449.915500844912;8477.576121193915;8496.150384961455;5967.880642387215;5997.370276120944;6054.576179667381;6061.090836374579;6171.691415429301;9917.107460328605;10284.897151028394;10429.530671119666;10617.203709721956;10683.30558513694;10506.21203409732;10604.310719803188;10699.679009629723;10703.464826758787;10861.511231994737;7005.684744186626;7454.888176677463;7855.37157027425;7927.920720792949;8054.718084867001;8752.256058235122;8801.075887032026;8830;8923.081537469476;8955.149260820472;7413.147488038944;7525.8118547036765;7533.434992375704;7775.961120194363;7824.765257042298;7425.331720145213;7477.70089196426;7520.135184453858;7606.20134885829;7711.922880771121;7096.8935465967015;7205.639718014183;7222.855542889218;7224.638768061681;7236.89144662841;5136.434992150786;5215.452377500308;5237.214417837355;5289.47105289468;5481.479259470344;5272.340957380327;5285;5306.761195746123;5350.571954243574;5553.722313884209 18:33:35 INFO - PROCESS | 25975 | |4;prototype.html;320.7738544326249;327.78038714061586;331.5027458811782;337.6235497420377;339.1047634245592;5291.86770330741;5440.755166017529;5462.579729270394;5505.752241149148;5594.86012849679;5213.635045546814;5364.463553644643;5372.355317361912;5402;5418.4039755626845;4225.239456897757;4237.533871274158;4242.448481697375;4252.744835309876;4255.553166917475;4157.792110394484;4231.576842315774;4232.534421213664;4255.404243405926;4270;4191.580841915815;4208.45290112285;4209.494860616715;4222.577742225783;4227.112306415656;4224.894377640569;4227.513835908879;4228.5560016198315;4247.04441500663;4266.957330426687;3671.81640917953;3766.9434958475645;3771.0383852117807;3771.4908487354132;3774.8678796242275;5228.816991405321;5246.685198888041;5256.763445644917;5290.180022096542;5308.416074231832;4774;4776.546228108324;4777.4267087949665;4791.9520804791855;4797.136515427222;5381.569474442035;5616.550675945915;5626.774929002876;5707.058335374658;5719.113537401709;4020.618041286073;4066.8373265069363;4071.185762847442;4083.3262511685534;4086.4687590613325;5948.791792287292;5953.315368732608;5970.761169553212;6005.279366476051;6010.398960103998;3934.8622798201927;4179.707420480538;4194.916101677949;4204.768737719455;4206.978965105155;4164.8125834337525;4183.184279065614;4203.5376108628025;4206.41110244566;4221.134667393177;4851.840930785837;4854.563089321978;4871.732054737024;4872.731999739977;4893.678706749158;5468.48049435303;5759.164921086419;5777.537796976232;5788.913166302509;5795.333536643256;1441.668416264265;1474.2260313335585;1479.201231335067;1479.2160155117804;1481.3852251315584;888.7778055486128;926.8784770427723;937.9155875971195;946.1342871272846;950.6340059077166;4833.806647734122;4869.22092465211;4893.559579637778;4913.336699545587;4918.409790825052;5131.794028403322;5141;5141.820036298712;5187.443766869999;5210.426853046162;4753.36009076868;4810.470848206694;4914.91871788206;4924.803007879645;5025.39695236574;2735.480258750831;2769.587510369726;2771.750542451189;2775.403288293027;2804.7518854110135;5283.656562323436;5341.839744807662;5356.223347614574;5357.5446087082255;5378.682222855426;4945.9968712671425;5167.483251674803;5212.618656056148;5268.551148434211;5297.629165958346;5321.521063104339;5331.680099194061;5334.026410228241;5340.359156901197;5395.568354531628;5193.831387937684;5212.4005739338945;5231.450697676842;5232.816851410183;5302.019126461617;5065.3161823153405;5462.153366228241;5780.219670344618;5820.185174075548;5829.8251052468495;6105;6108.5723999319625;6112.694365281629;6120.17377654011;6136.662483563447;3921.549021862408;4035.858744943913;4062.2938365885807;4137.317342638431;4171.186618609342;5765.538756899354;5812.33158186797;5814.73833677494;5841.211436456024;5858.765649374148;5666.178404131296;5751.4536119068625;5763.550491041206;5780.161876527964;5820.621659592113;5671.688057156896;5678.4605462480995;5693.060644993529;5694.088945768657;5703.663356936238;5580.154121398197;5599.300087489064;5613.831585052455;5615;5644.322681278273;5556.222008957257;5674.943250567441;5681.460261275172;5682.119271512922;5705.144228365612;5578.493806672257;5583.664980101207;5604.6917419542315;5604.747786349542;5633.155026746021 18:33:35 INFO - PROCESS | 25975 | |5;yui.html;698.6087790837131;754.6981207516992;762.1654288554033;762.8855671649252;775.0002496779155;14038.859611403883;14828;15296.464623738157;15764.84235157648;15829.84170158298;16093.919530402332;16304.83695163048;16345.83654163461;16393.672126557463;16402;774.4617490843838;783.7883771381723;794.9920500795005;795.026093036032;795.3239746215728;796.1481215099845;799.7960520067404;801.5591424716382;802.9919700802975;808.9878651820227;835.1356346181703;840.369722707969;841.7668116209752;842.6671464771412;844.9366297527679;835.908050114487;837.0541288344193;838.2120806441986;838.8532006898798;839.5844057191699;607.1863702638442;608.9451949324538;611.0284647410639;616.2789536242607;617.5985609353911;14673.77989330161;14709.190994495299;14709.926450367786;14783.113013219241;14826.703465930621;14340.713185736331;14402;14449.78325325121;14456.204908730017;14562;11506.194566380356;11637;11761.764764704658;11943.820842687366;11975.22161059537;3687.870924517656;3700.389435743126;3736.1033351995598;3737.364648009845;3737.588865224823;76352.61823690901;79016.60491697505;79280;79778;79799.6010019952;10783.13734901206;10800.081993030522;10819.513121909533;11064.336139831636;11080.612178573872;18425.631487370178;18446.446606601825;18461.5384615383;18471.53821154482;18476.815231847508;7531.284527969834;7683.5774032427635;7844.686212551434;7946.364290856717;8047.839043219103;4687.835925742651;4705.388299521041;4729.95270047302;4738.786754596052;4888.413390393175;3365.6802603752603;3464.8094354810223;3476.409010468176;3490.3717330880177;3491.284286721216;593.1991811055127;605.1437216338919;611.9602225855305;628.522323034497;629.8488362792897;541.8997485465122;583.215575051555;592.2241863159189;641.9261784894703;652.5660435810133;9230.86153707695;9241.445513269226;9245.815083698288;9295.163435290857;9387.57755900986;551.5229326632514;589.4311988930702;622.2657264428018;643.9903401448983;665.0523004718257;4372.650187984954;4421.845235416745;4474.440694913136;4535.886602834956;4589.79345929434;86878.56560717156;87496.68860931532;90414.54792725995;106493.46753266185;125337;54050.45949540533;88957;91654.54172729226;92729;94135;50414.243786343235;66783;82662.58668706738;82998.58500707458;85050;8888.73333799987;9365.62814470907;9369.109934556207;9467.857982130412;9506.191973682038;47082;47133.7643311795;49070.509294906595;49293.098966144054;50661.24008139807;74731.25268747461;75508.62245688736;75696;75783;77252;12409.93795031019;12535.811962820382;12544.435500402686;12589.496420143092;12677.556285529961;14508.927455362656;14767.630809229855;14850.183239921907;14869.851301486846;15726;13787.793183102061;13935.930320348334;13982.370793314121;14267.857321426653;14933.328000240233;12747.553835615709;12990.285534295705;13017.739645207232;13128.803067954179;13377.210450852224;13521.18872867631;13829.10110842792;13891.444342226197;13912;14122.418879056015;10148.41775451746;10449.58201671955;10800.556217719632;10939.398333091438;10943.781124377627;10084.26039761311;10786.946065269938;11738.237014594024;11820.527178913091;12084.516619335129 18:33:35 INFO - PROCESS | 25975 | __end_tp_report 18:33:35 INFO - PROCESS | 25975 | __start_cc_report 18:33:35 INFO - PROCESS | 25975 | _x_x_mozilla_cycle_collect,318 18:33:35 INFO - PROCESS | 25975 | __end_cc_report 18:33:35 INFO - PROCESS | 25975 | __startTimestamp1475285615924__endTimestamp 18:33:35 INFO - PROCESS | 25975 | 18:33:35 INFO - PROCESS | 25975 | ------- Summary: start ------- 18:33:35 INFO - PROCESS | 25975 | Number of tests: 6 18:33:35 INFO - PROCESS | 25975 | 18:33:35 INFO - PROCESS | 25975 | [#0] dojo.html Cycles:165 Average:5324.95 Median:5527.39 stddev:612.01 (11.1%) stddev-sans-first:585.32 18:33:35 INFO - PROCESS | 25975 | Values: 2969.3 2975.5 2999.3 3004.5 3023.8 5252.3 5278.3 5329.1 5338.1 5347.4 5347.8 5381.9 5387.4 5426.4 5464.7 4877.0 4960.2 4971.0 5016.7 5021.7 4911.7 4978.8 5005.5 5011.6 5016.0 4734.6 4790.4 4798.6 4807.3 4924.8 4816.3 4846.1 4872.8 4887.6 4889.3 4768.5 4804.6 4821.5 4847.3 4859.5 5095.7 5178.4 5252.8 5287.5 5366.2 5696.2 5702.7 5718.0 5722.8 5772.0 5730.7 5730.7 5742.1 5751.7 5753.5 5238.2 5318.1 5334.9 5371.8 5378.9 5872.7 5911.6 5919.3 5972.2 5984.2 5649.7 5665.1 5677.0 5680.0 5690.7 5590.1 5625.4 5705.2 5755.6 5792.4 5637.2 5668.0 5676.8 5680.4 5718.7 5670.6 5672.3 5675.2 5678.9 5680.5 4399.2 4401.6 4416.5 4419.7 4469.9 3901.4 3909.3 3914.4 3974.0 3982.3 5448.2 5470.3 5472.4 5483.5 5488.3 5616.4 5711.2 5724.3 5748.0 5770.9 5481.6 5496.6 5499.0 5499.6 5557.8 4959.6 5017.9 5018.5 5023.7 5074.7 5796.0 5853.2 5905.3 5969.9 5977.7 5777.5 5787.9 5798.7 5857.8 5866.4 5958.9 6000.5 6007.3 6008.4 6023.5 5538.4 5563.1 5635.2 5659.4 5668.2 5670.5 5719.6 5783.6 5806.6 5814.5 5527.4 5542.3 5547.4 5548.1 5589.3 5467.7 5585.8 5594.4 5597.4 5598.2 5443.9 5465.3 5518.1 5530.1 5556.7 5537.5 5628.5 5632.2 5632.9 5635.1 5395.2 5487.3 5519.9 5523.0 5556.0 18:33:35 INFO - PROCESS | 25975 | 18:33:35 INFO - PROCESS | 25975 | [#1] ext.html Cycles:180 Average:55279.73 Median:38274.33 stddev:109906.66 (287.2%) stddev-sans-first:110138.09 18:33:35 INFO - PROCESS | 25975 | Values: 525.7 577.6 581.3 591.8 593.6 30292.0 34094.1 34172.8 40010.8 41019.4 42414.8 42768.1 42805.6 42870.4 42889.8 8736.2 8882.9 8884.2 8895.4 8897.8 8785.3 8853.5 8855.2 8876.2 8883.6 8771.8 8814.7 8818.6 8831.2 8843.0 8731.2 8772.5 8774.4 8796.9 8832.3 8584.9 8590.3 8651.2 8673.8 8677.9 39865.4 40109.8 40192.4 40346.8 40376.4 3334.2 3476.1 3573.5 3807.3 3814.0 29921.0 30426.4 30457.8 30482.0 31451.0 3709.5 3793.8 3813.1 3888.3 3978.2 296188.0 297791.6 297871.5 298349.0 299831.0 52157.0 52929.0 52954.7 53030.0 53204.7 34961.8 35398.8 35452.6 36917.0 36981.4 14974.7 15112.7 15152.1 15158.7 15177.7 11370.3 11392.9 11420.9 11436.7 11447.7 17675.2 17887.0 17894.6 17925.8 17935.0 6782.4 6798.7 6858.4 6897.5 7039.8 945.7 1016.7 1101.7 1103.6 1150.6 30615.2 30827.0 30838.8 31236.8 31270.2 1019.9 1023.3 1073.2 1074.8 1096.2 15703.4 15960.9 16031.4 16200.5 16350.3 499722.0 499733.0 504730.0 507237.0 507621.0 54054.5 54894.0 55070.0 55077.4 55202.0 1247.0 1315.7 1320.5 1321.9 1331.1 28866.9 30211.4 30751.4 30917.5 31075.5 46308.1 46488.3 46667.0 46934.8 46976.3 412480.0 415299.0 415936.4 416138.0 416533.0 26811.6 27064.2 27187.5 27589.7 27695.6 44260.3 44400.8 44796.8 45184.8 46037.1 35545.3 36217.3 36371.0 36643.8 37356.0 38277.4 38395.8 38903.4 39230.8 39301.2 38271.2 38533.2 38564.4 38998.0 39867.0 32715.7 35272.0 35662.0 35769.6 36190.5 27560.0 27751.3 27793.3 27859.3 28075.9 18:33:35 INFO - PROCESS | 25975 | 18:33:35 INFO - PROCESS | 25975 | [#2] jquery.html Cycles:180 Average:25981.84 Median:22501.22 stddev:67237.09 (298.8%) stddev-sans-first:67398.24 18:33:35 INFO - PROCESS | 25975 | Values: 386.9 389.9 400.9 401.5 416.5 16034.6 16541.9 17681.3 19167.5 19283.2 11830.4 12051.2 12519.7 12797.6 18599.4 5107.6 5319.9 5377.4 5378.0 5384.5 4586.8 5218.3 5774.7 5810.6 5831.7 5741.2 5768.0 5784.8 5788.0 5797.3 5559.6 5678.3 5699.2 5715.2 5744.4 4953.0 5110.4 5121.1 5137.0 5143.8 13436.1 14893.3 22021.1 22448.9 22553.5 2154.3 2307.7 2436.9 2611.2 2625.7 10069.2 10121.5 10613.9 11039.5 14330.6 1855.2 1906.8 1920.7 1935.8 1946.3 82147.0 83059.6 83442.2 83672.6 84000.0 9947.6 9995.8 10059.7 10070.0 10176.5 13666.9 13686.2 13704.7 13722.7 13755.4 7177.6 7404.9 7446.3 7634.3 7660.9 7130.0 7188.0 7195.0 7363.7 7469.5 4187.5 4226.1 4281.8 4374.6 4633.9 1796.4 1830.3 1849.6 1849.9 1858.4 929.5 1042.3 1045.2 1071.3 1078.5 17646.6 17787.9 18650.8 18841.5 19500.1 1007.9 1020.6 1064.2 1064.5 1075.5 10051.2 10689.7 10696.7 10755.5 10758.8 397609.0 405433.0 405478.0 405683.0 406473.0 85106.6 90294.5 90760.5 91127.0 91605.0 982.0 1002.8 1006.1 1006.8 1012.4 16129.5 16527.0 16605.5 17114.8 17343.5 39480.2 40641.4 40769.8 41394.2 41907.2 51878.7 53491.5 54381.5 56232.7 56708.4 8118.5 8266.8 8300.7 8494.5 8590.0 11738.8 12805.3 12922.7 13109.7 13150.5 10801.4 10861.8 11137.2 11303.8 12044.0 11113.3 11447.7 11546.7 11577.9 11599.4 11354.1 11398.1 11430.1 11844.0 11845.8 8396.9 8426.9 8480.4 8531.9 8818.8 11324.8 11326.3 11669.8 11915.8 12146.0 18:33:35 INFO - PROCESS | 25975 | 18:33:35 INFO - PROCESS | 25975 | [#3] mootools.html Cycles:180 Average:5871.70 Median:2288.11 stddev:3459.59 (151.2%) stddev-sans-first:3453.53 18:33:35 INFO - PROCESS | 25975 | Values: 1476.1 1500.9 1633.2 1684.9 1737.6 7957.7 8193.6 8626.7 9274.5 9279.9 8755.4 9033.2 9037.6 9164.6 9182.0 2323.6 2331.5 2344.4 2351.8 2359.3 2242.4 2275.9 2341.2 2346.6 2348.8 2273.9 2295.8 2299.4 2319.9 2325.4 2241.9 2243.5 2257.8 2259.6 2260.5 2200.8 2213.2 2219.0 2225.1 2227.4 8834.1 9186.2 9250.8 9277.3 9320.8 5089.9 5186.7 5191.1 5228.6 5247.4 3241.5 3275.8 3399.6 3434.6 3444.2 1065.7 1073.6 1083.4 1098.1 1104.1 12797.6 12894.4 12910.5 12918.7 12951.8 4397.5 4465.9 4649.4 4691.4 4694.7 10594.6 10726.7 10757.0 10766.3 10767.9 5129.4 5135.9 5141.7 5159.0 5205.0 4066.0 4159.9 4541.5 4670.1 4705.1 3773.8 3893.0 3976.6 3976.7 4053.3 1258.8 1265.9 1302.9 1304.8 1309.7 843.5 985.4 986.2 989.0 1011.5 5923.5 6100.4 6134.8 6150.1 6174.4 392.4 397.8 398.5 403.8 416.4 3872.8 3925.8 3942.8 3959.8 3968.4 10898.6 11113.4 11220.9 11306.2 11316.0 11108.7 11202.6 11207.2 11254.4 11270.3 8414.6 8428.3 8449.9 8477.6 8496.2 5967.9 5997.4 6054.6 6061.1 6171.7 9917.1 10284.9 10429.5 10617.2 10683.3 10506.2 10604.3 10699.7 10703.5 10861.5 7005.7 7454.9 7855.4 7927.9 8054.7 8752.3 8801.1 8830.0 8923.1 8955.1 7413.1 7525.8 7533.4 7776.0 7824.8 7425.3 7477.7 7520.1 7606.2 7711.9 7096.9 7205.6 7222.9 7224.6 7236.9 5136.4 5215.5 5237.2 5289.5 5481.5 5272.3 5285.0 5306.8 5350.6 5553.7 18:33:35 INFO - PROCESS | 25975 | 18:33:35 INFO - PROCESS | 25975 | [#4] prototype.html Cycles:180 Average:4654.59 Median:5213.13 stddev:1356.82 (26.0%) stddev-sans-first:1321.06 18:33:35 INFO - PROCESS | 25975 | Values: 320.8 327.8 331.5 337.6 339.1 5291.9 5440.8 5462.6 5505.8 5594.9 5213.6 5364.5 5372.4 5402.0 5418.4 4225.2 4237.5 4242.4 4252.7 4255.6 4157.8 4231.6 4232.5 4255.4 4270.0 4191.6 4208.5 4209.5 4222.6 4227.1 4224.9 4227.5 4228.6 4247.0 4267.0 3671.8 3766.9 3771.0 3771.5 3774.9 5228.8 5246.7 5256.8 5290.2 5308.4 4774.0 4776.5 4777.4 4792.0 4797.1 5381.6 5616.6 5626.8 5707.1 5719.1 4020.6 4066.8 4071.2 4083.3 4086.5 5948.8 5953.3 5970.8 6005.3 6010.4 3934.9 4179.7 4194.9 4204.8 4207.0 4164.8 4183.2 4203.5 4206.4 4221.1 4851.8 4854.6 4871.7 4872.7 4893.7 5468.5 5759.2 5777.5 5788.9 5795.3 1441.7 1474.2 1479.2 1479.2 1481.4 888.8 926.9 937.9 946.1 950.6 4833.8 4869.2 4893.6 4913.3 4918.4 5131.8 5141.0 5141.8 5187.4 5210.4 4753.4 4810.5 4914.9 4924.8 5025.4 2735.5 2769.6 2771.8 2775.4 2804.8 5283.7 5341.8 5356.2 5357.5 5378.7 4946.0 5167.5 5212.6 5268.6 5297.6 5321.5 5331.7 5334.0 5340.4 5395.6 5193.8 5212.4 5231.5 5232.8 5302.0 5065.3 5462.2 5780.2 5820.2 5829.8 6105.0 6108.6 6112.7 6120.2 6136.7 3921.5 4035.9 4062.3 4137.3 4171.2 5765.5 5812.3 5814.7 5841.2 5858.8 5666.2 5751.5 5763.6 5780.2 5820.6 5671.7 5678.5 5693.1 5694.1 5703.7 5580.2 5599.3 5613.8 5615.0 5644.3 5556.2 5674.9 5681.5 5682.1 5705.1 5578.5 5583.7 5604.7 5604.7 5633.2 18:33:35 INFO - PROCESS | 25975 | 18:33:35 INFO - PROCESS | 25975 | [#5] yui.html Cycles:180 Average:19502.66 Median:25931.86 stddev:27293.94 (105.3%) stddev-sans-first:27333.99 18:33:35 INFO - PROCESS | 25975 | Values: 698.6 754.7 762.2 762.9 775.0 14038.9 14828.0 15296.5 15764.8 15829.8 16093.9 16304.8 16345.8 16393.7 16402.0 774.5 783.8 795.0 795.0 795.3 796.1 799.8 801.6 803.0 809.0 835.1 840.4 841.8 842.7 844.9 835.9 837.1 838.2 838.9 839.6 607.2 608.9 611.0 616.3 617.6 14673.8 14709.2 14709.9 14783.1 14826.7 14340.7 14402.0 14449.8 14456.2 14562.0 11506.2 11637.0 11761.8 11943.8 11975.2 3687.9 3700.4 3736.1 3737.4 3737.6 76352.6 79016.6 79280.0 79778.0 79799.6 10783.1 10800.1 10819.5 11064.3 11080.6 18425.6 18446.4 18461.5 18471.5 18476.8 7531.3 7683.6 7844.7 7946.4 8047.8 4687.8 4705.4 4730.0 4738.8 4888.4 3365.7 3464.8 3476.4 3490.4 3491.3 593.2 605.1 612.0 628.5 629.8 541.9 583.2 592.2 641.9 652.6 9230.9 9241.4 9245.8 9295.2 9387.6 551.5 589.4 622.3 644.0 665.1 4372.7 4421.8 4474.4 4535.9 4589.8 86878.6 87496.7 90414.5 106493.5 125337.0 54050.5 88957.0 91654.5 92729.0 94135.0 50414.2 66783.0 82662.6 82998.6 85050.0 8888.7 9365.6 9369.1 9467.9 9506.2 47082.0 47133.8 49070.5 49293.1 50661.2 74731.3 75508.6 75696.0 75783.0 77252.0 12409.9 12535.8 12544.4 12589.5 12677.6 14508.9 14767.6 14850.2 14869.9 15726.0 13787.8 13935.9 13982.4 14267.9 14933.3 12747.6 12990.3 13017.7 13128.8 13377.2 13521.2 13829.1 13891.4 13912.0 14122.4 10148.4 10449.6 10800.6 10939.4 10943.8 10084.3 10786.9 11738.2 11820.5 12084.5 18:33:35 INFO - PROCESS | 25975 | -------- Summary: end -------- 18:33:35 INFO - PROCESS | 25975 | 18:33:36 INFO - TEST-INFO | 25975: exit 0 18:33:36 INFO - TEST-OK | dromaeo_css | took 1114495ms 18:33:36 INFO - TEST-START | kraken 18:33:36 INFO - operating with platform_type : linux_ 18:33:36 INFO - Initialising browser for kraken test... 18:33:36 INFO - TEST-INFO | started process 26339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKcqdht/profile http://localhost:46590/getInfo.html) 18:33:42 INFO - PROCESS | 26339 | __metrics Screen width/height:1600/1200 18:33:42 INFO - PROCESS | 26339 | colorDepth:24 18:33:42 INFO - PROCESS | 26339 | Browser inner width/height: 1024/697 18:33:42 INFO - PROCESS | 26339 | __metrics 18:33:42 ERROR - PROCESS | 26339 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 18:33:43 INFO - TEST-INFO | 26339: exit 0 18:33:43 INFO - Browser initialized. 18:33:43 INFO - Running cycle 1/1 for kraken test... 18:33:43 INFO - TEST-INFO | started process 26462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKcqdht/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:33:55 INFO - PROCESS | 26462 | RSS: Main: 185786368 18:33:55 INFO - PROCESS | 26462 | 18:33:58 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46590/tests/kraken/driver.html?testName=audio-beat-detection) 18:33:59 INFO - PROCESS | 26462 | RSS: Main: 199626752 18:33:59 INFO - PROCESS | 26462 | 18:34:02 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46590/tests/kraken/driver.html?testName=audio-dft) 18:34:02 INFO - PROCESS | 26462 | RSS: Main: 197451776 18:34:02 INFO - PROCESS | 26462 | 18:34:05 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46590/tests/kraken/driver.html?testName=audio-fft) 18:34:06 INFO - PROCESS | 26462 | RSS: Main: 193290240 18:34:06 INFO - PROCESS | 26462 | 18:34:08 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46590/tests/kraken/driver.html?testName=audio-oscillator) 18:34:08 INFO - PROCESS | 26462 | RSS: Main: 193871872 18:34:08 INFO - PROCESS | 26462 | 18:34:11 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46590/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:34:11 INFO - PROCESS | 26462 | RSS: Main: 194695168 18:34:11 INFO - PROCESS | 26462 | 18:34:14 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46590/tests/kraken/driver.html?testName=imaging-darkroom) 18:34:15 INFO - PROCESS | 26462 | RSS: Main: 194449408 18:34:15 INFO - PROCESS | 26462 | 18:34:18 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46590/tests/kraken/driver.html?testName=imaging-desaturate) 18:34:19 INFO - PROCESS | 26462 | RSS: Main: 192528384 18:34:19 INFO - PROCESS | 26462 | 18:34:22 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46590/tests/kraken/driver.html?testName=json-parse-financial) 18:34:22 INFO - PROCESS | 26462 | RSS: Main: 194195456 18:34:22 INFO - PROCESS | 26462 | 18:34:24 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46590/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:34:25 INFO - PROCESS | 26462 | RSS: Main: 194252800 18:34:25 INFO - PROCESS | 26462 | 18:34:26 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46590/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:34:27 INFO - PROCESS | 26462 | RSS: Main: 194404352 18:34:27 INFO - PROCESS | 26462 | 18:34:29 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46590/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:34:30 INFO - PROCESS | 26462 | RSS: Main: 194904064 18:34:30 INFO - PROCESS | 26462 | 18:34:33 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:34:33 INFO - PROCESS | 26462 | RSS: Main: 194646016 18:34:33 INFO - PROCESS | 26462 | 18:34:36 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:34:37 INFO - PROCESS | 26462 | RSS: Main: 195596288 18:34:37 INFO - PROCESS | 26462 | 18:34:38 INFO - PROCESS | 26462 | Cycle 1(1): loaded http://localhost:46590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46590/tests/kraken/driver.html?testName=ai-astar) 18:34:39 INFO - PROCESS | 26462 | RSS: Main: 196173824 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | __start_tp_report 18:34:39 INFO - PROCESS | 26462 | _x_x_mozilla_page_load 18:34:39 INFO - PROCESS | 26462 | _x_x_mozilla_page_load_details 18:34:39 INFO - PROCESS | 26462 | |i|pagename|runs| 18:34:39 INFO - PROCESS | 26462 | |0;ai-astar;108;113;114;115;115;113;114;114;114;114 18:34:39 INFO - PROCESS | 26462 | |1;audio-beat-detection;167;129;132;169;126;127;136;124;159;125 18:34:39 INFO - PROCESS | 26462 | |2;audio-dft;163;168;165;166;167;164;162;164;163;162 18:34:39 INFO - PROCESS | 26462 | |3;audio-fft;77;75;76;114;78;76;76;75;115;76 18:34:39 INFO - PROCESS | 26462 | |4;audio-oscillator;84;86;106;84;83;84;101;83;82;106 18:34:39 INFO - PROCESS | 26462 | |5;imaging-gaussian-blur;118;118;118;117;118;118;117;119;117;118 18:34:39 INFO - PROCESS | 26462 | |6;imaging-darkroom;148;149;146;146;146;147;147;149;146;148 18:34:39 INFO - PROCESS | 26462 | |7;imaging-desaturate;96;96;96;96;96;96;97;96;97;96 18:34:39 INFO - PROCESS | 26462 | |8;json-parse-financial;57;53;56;53;56;56;56;54;54;59 18:34:39 INFO - PROCESS | 26462 | |9;json-stringify-tinderbox;61;60;60;61;61;60;60;63;61;61 18:34:39 INFO - PROCESS | 26462 | |10;stanford-crypto-aes;83;86;81;81;84;81;83;80;81;80 18:34:39 INFO - PROCESS | 26462 | |11;stanford-crypto-ccm;138;140;133;131;130;134;147;130;167;149 18:34:39 INFO - PROCESS | 26462 | |12;stanford-crypto-pbkdf2;166;166;172;169;169;168;167;171;169;172 18:34:39 INFO - PROCESS | 26462 | |13;stanford-crypto-sha256-iterative;74;67;65;66;67;66;75;66;66;71 18:34:39 INFO - PROCESS | 26462 | __end_tp_report 18:34:39 INFO - PROCESS | 26462 | __start_cc_report 18:34:39 INFO - PROCESS | 26462 | _x_x_mozilla_cycle_collect,761 18:34:39 INFO - PROCESS | 26462 | __end_cc_report 18:34:39 INFO - PROCESS | 26462 | __startTimestamp1475285679156__endTimestamp 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | ------- Summary: start ------- 18:34:39 INFO - PROCESS | 26462 | Number of tests: 14 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.01 (1.8%) stddev-sans-first:0.71 18:34:39 INFO - PROCESS | 26462 | Values: 108.0 113.0 114.0 115.0 115.0 113.0 114.0 114.0 114.0 114.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:134.00 stddev:18.18 (13.6%) stddev-sans-first:16.31 18:34:39 INFO - PROCESS | 26462 | Values: 167.0 129.0 132.0 169.0 126.0 127.0 136.0 124.0 159.0 125.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:2.07 (1.3%) stddev-sans-first:2.13 18:34:39 INFO - PROCESS | 26462 | Values: 163.0 168.0 165.0 166.0 167.0 164.0 162.0 164.0 163.0 162.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.00 stddev:16.21 (21.3%) stddev-sans-first:17.00 18:34:39 INFO - PROCESS | 26462 | Values: 77.0 75.0 76.0 114.0 78.0 76.0 76.0 75.0 115.0 76.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:83.50 stddev:10.10 (12.1%) stddev-sans-first:10.49 18:34:39 INFO - PROCESS | 26462 | Values: 84.0 86.0 106.0 84.0 83.0 84.0 101.0 83.0 82.0 106.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 18:34:39 INFO - PROCESS | 26462 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 117.0 119.0 117.0 118.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:1.23 (0.8%) stddev-sans-first:1.27 18:34:39 INFO - PROCESS | 26462 | Values: 148.0 149.0 146.0 146.0 146.0 147.0 147.0 149.0 146.0 148.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:34:39 INFO - PROCESS | 26462 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.90 (3.4%) stddev-sans-first:1.92 18:34:39 INFO - PROCESS | 26462 | Values: 57.0 53.0 56.0 53.0 56.0 56.0 56.0 54.0 54.0 59.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 18:34:39 INFO - PROCESS | 26462 | Values: 61.0 60.0 60.0 61.0 61.0 60.0 60.0 63.0 61.0 61.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.94 (2.4%) stddev-sans-first:2.03 18:34:39 INFO - PROCESS | 26462 | Values: 83.0 86.0 81.0 81.0 84.0 81.0 83.0 80.0 81.0 80.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:139.00 stddev:11.69 (8.4%) stddev-sans-first:12.37 18:34:39 INFO - PROCESS | 26462 | Values: 138.0 140.0 133.0 131.0 130.0 134.0 147.0 130.0 167.0 149.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:169.00 stddev:2.23 (1.3%) stddev-sans-first:2.11 18:34:39 INFO - PROCESS | 26462 | Values: 166.0 166.0 172.0 169.0 169.0 168.0 167.0 171.0 169.0 172.0 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:67.00 stddev:3.65 (5.5%) stddev-sans-first:3.24 18:34:39 INFO - PROCESS | 26462 | Values: 74.0 67.0 65.0 66.0 67.0 66.0 75.0 66.0 66.0 71.0 18:34:39 INFO - PROCESS | 26462 | -------- Summary: end -------- 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | 18:34:39 INFO - PROCESS | 26462 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:34:39 INFO - PROCESS | 26462 | 18:34:40 INFO - TEST-INFO | 26462: exit 0 18:34:40 INFO - TEST-OK | kraken | took 63358ms 18:34:40 INFO - SUITE-END | took 1177s 18:34:40 INFO - Completed test suite (00:19:38) 18:34:40 INFO - javascript benchmark 18:34:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7049.155858808565, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2969.2576855786056, 2975.4941659917813, 2999.340145168064, 3004.4591973444785, 3023.7732170087247, 5252.264682944391, 5278.261043453919, 5329.120695085307, 5338.0658384782655, 5347.385050719168, 5347.812826551071, 5381.919271210935, 5387.380451248107, 5426.430224826396, 5464.726763661811, 4876.97561512192, 4960.23116416956, 4970.975145124269, 5016.673916195454, 5021.698698078127, 4911.68074075184, 4978.775955082012, 5005.499450054984, 5011.599072074226, 5015.974920125394, 4734.644901632374, 4790.449098353699, 4798.64010199233, 4807.254875494304, 4924.75376231187, 4816.349792778, 4846.0550192712435, 4872.756362181912, 4887.560119589219, 4889.29105279736, 4768.451628062748, 4804.615630749532, 4821.54195351441, 4847.297141914402, 4859.538343857328, 5095.745212739348, 5178.40448348441, 5252.844374237661, 5287.524122828964, 5366.221897824833, 5696.174054762037, 5702.7433765480655, 5717.9714101429645, 5722.828315150552, 5771.971140144315, 5730.68481233532, 5730.7421166047625, 5742.052561327376, 5751.712414379306, 5753.453421924911, 5238.161894096965, 5318.069337865935, 5334.946650533522, 5371.785128594852, 5378.865528361783, 5872.706364681749, 5911.615744976649, 5919.253820123074, 5972.223610930551, 5984.192134061933, 5649.745761440663, 5665.065264231438, 5676.971615141898, 5679.971600141973, 5690.658560486384, 5590.133529302964, 5625.38120806711, 5705.22979397776, 5755.59710820247, 5792.391798861143, 5637.238972738628, 5668.036433806263, 5676.801311954062, 5680.403557626472, 5718.714064296852, 5670.631408958405, 5672.347680016851, 5675.1770993205755, 5678.914816277759, 5680.517156041783, 4399.186150562156, 4401.603855653007, 4416.514183439819, 4419.668524860584, 4469.865904022885, 3901.3562762144497, 3909.3354129798004, 3914.432407300925, 3974.0, 3982.283189026003, 5448.210009548593, 5470.316210473691, 5472.370677372153, 5483.479069488392, 5488.259085023471, 5616.438356164351, 5711.200431939532, 5724.25584673998, 5747.971260143756, 5770.913436298459, 5481.561475081984, 5496.560275177976, 5499.0, 5499.587530935196, 5557.777688892399, 4959.62802789785, 5017.89964200714, 5018.548330650186, 5023.748812559431, 5074.67014644047, 5796.043652797325, 5853.180554722342, 5905.320888097924, 5969.850753731104, 5977.701114944322, 5777.480026797609, 5787.855303617275, 5798.739056742541, 5857.765689372548, 5866.41335866427, 5958.910616340845, 6000.459958603747, 6007.339192688888, 6008.429199226067, 6023.518118550418, 5538.418466061166, 5563.082091454865, 5635.211070450058, 5659.434056594472, 5668.206451096932, 5670.489655930986, 5719.599628025998, 5783.566232532661, 5806.622569532967, 5814.505767009851, 5527.391986881359, 5542.307211598551, 5547.44525547442, 5548.140038294071, 5589.329280486368, 5467.7266136692215, 5585.776568937197, 5594.440555944373, 5597.44025597437, 5598.244237028112, 5443.918341224806, 5465.289512363367, 5518.117101263779, 5530.11518157109, 5556.749946252509, 5537.501624853782, 5628.493435590653, 5632.183333416713, 5632.943670563406, 5635.0702134147405, 5395.244665746877, 5487.259220005249, 5519.8896022080135, 5523.005858945428, 5556.027695153412], "value": 5282.327933295994, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.6583220906408, 577.5783677915122, 581.276310992814, 591.7603370634895, 593.6467801658014, 30292.0, 34094.147646308855, 34172.829135854314, 40010.799946000305, 41019.38470922939, 42414.78792606033, 42768.14463710724, 42805.57194428055, 42870.35694464586, 42889.78555107228, 8736.170063843925, 8882.86675699865, 8884.244839188645, 8895.421797583136, 8897.822043559125, 8785.253253473462, 8853.513056781874, 8855.24730397917, 8876.156765107304, 8883.555822208897, 8771.824563508726, 8814.735557933273, 8818.603162857687, 8831.161039701217, 8842.955785221096, 8731.214190722834, 8772.473651580925, 8774.429662071945, 8796.912030879705, 8832.33757468186, 8584.914150858474, 8590.312774977987, 8651.178138076935, 8673.82652346956, 8677.913220867773, 39865.40201896974, 40109.79945100285, 40192.39711404331, 40346.79826600877, 40376.39435408471, 3334.216459132102, 3476.1135910342955, 3573.4639804029343, 3807.295650304675, 3814.0083578269573, 29921.0, 30426.39147217043, 30457.847710761303, 30482.0, 31451.0, 3709.51776269086, 3793.7723736575895, 3813.0848596336677, 3888.319544079775, 3978.1645854370618, 296188.0, 297791.5552111193, 297871.51064244757, 298349.0, 299831.0, 52157.0, 52929.0, 52954.735226323624, 53030.0, 53204.73397632987, 34961.82519087388, 35398.82300588532, 35452.64547354545, 36917.0, 36981.44527832085, 14974.727148192525, 15112.697746045238, 15152.090874547563, 15158.696826063637, 15177.696446071017, 11370.260933039326, 11392.886071139348, 11420.94289528547, 11436.714082148013, 11447.656570302905, 17675.20461579232, 17887.0, 17894.642107157782, 17925.820741792417, 17935.0, 6782.423494002966, 6798.728050878009, 6858.3827455529245, 6897.517173797886, 7039.753608623673, 945.7493764152505, 1016.7153197104675, 1101.7190616392768, 1103.5530610102921, 1150.5800382860195, 30615.234619134255, 30827.0, 30838.75741124014, 31236.843815780776, 31270.218244544067, 1019.8572199892021, 1023.2581378500528, 1073.2326386633595, 1074.7904158689137, 1096.221682605359, 15703.371865125268, 15960.920195399181, 16031.43889963869, 16200.51398458048, 16350.264238109075, 499722.0, 499733.0, 504730.0, 507237.0, 507621.0, 54054.459455405726, 54894.0, 55070.0, 55077.44922550803, 55202.0, 1247.0460098025019, 1315.7105436803888, 1320.5312114199512, 1321.861204573506, 1331.134762404445, 28866.855665722378, 30211.395772084874, 30751.38497229998, 30917.536236956013, 31075.533866992464, 46308.07383852371, 46488.302675460574, 46667.0, 46934.765326173154, 46976.29535557038, 412480.0, 415299.0, 415936.44222452067, 416138.0, 416533.0, 26811.597826032234, 27064.1880743578, 27187.456250875268, 27589.72410275952, 27695.584566231926, 44260.33609495796, 44400.78976292234, 44796.77601611971, 45184.77407612941, 46037.07925841397, 35545.289094217456, 36217.27565448729, 36371.0, 36643.81678091593, 37356.0, 38277.42583861189, 38395.80802095972, 38903.41644875386, 39230.80384598059, 39301.2139757209, 38271.23457530778, 38533.22933541369, 38564.421533676454, 38998.0, 39867.0, 32715.672843272216, 35272.0, 35662.0, 35769.642303576635, 36190.45714314235, 27560.0, 27751.30621734392, 27793.305167370978, 27859.303517412227, 28075.859620701765], "value": 18797.71625199857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.94776205212287, 389.8752399232245, 400.85569195089766, 401.50213734968645, 416.5272415808059, 16034.59913502163, 16541.91729041356, 17681.29274829007, 19167.520811979706, 19283.22867085317, 11830.408479576008, 12051.216670916385, 12519.749605007893, 12797.616071517847, 18599.442016739486, 5107.616928730342, 5319.9202011969855, 5377.381601115863, 5378.0, 5384.515393614574, 4586.793594288249, 5218.347706536683, 5774.711264436783, 5810.5932584719085, 5831.650100993933, 5741.196232527429, 5768.0, 5784.82645520635, 5788.0, 5797.3043234811885, 5559.555235581164, 5678.346990096151, 5699.173619825144, 5715.171300161495, 5744.368119506872, 4952.950470495321, 5110.437851836295, 5121.078205922932, 5137.023965446553, 5143.794248230066, 13436.126651767701, 14893.32980015902, 22021.119155233773, 22448.887755561118, 22553.548929021326, 2154.289084602093, 2307.723073231223, 2436.9390765230833, 2611.190530935416, 2625.671791026122, 10069.244806639457, 10121.544530496072, 10613.893861061444, 11039.503222355013, 14330.64173395663, 1855.1837191635773, 1906.8474522038205, 1920.711893216015, 1935.796741342153, 1946.3285166617495, 82147.0, 83059.58470207671, 83442.16557834405, 83672.58163709204, 84000.0, 9947.602095916227, 9995.80008399828, 10059.748506287255, 10069.979006298081, 10176.542055607515, 13666.863331366758, 13686.178829270275, 13704.65738356529, 13722.65693357674, 13755.38100785467, 7177.569345839266, 7404.925950740531, 7446.329830315298, 7634.274743899321, 7660.885086723703, 7129.964350178216, 7188.0, 7195.0, 7363.7422690205585, 7469.477136600386, 4187.497500299984, 4226.112516371535, 4281.785910704452, 4374.58441448062, 4633.907321853544, 1796.4341232511717, 1830.2587452081927, 1849.6431908084373, 1849.9188413035336, 1858.4145994012113, 929.5027160469117, 1042.3120740311358, 1045.1847558904067, 1071.2661826648614, 1078.4607696151925, 17646.647067058842, 17787.911060444614, 18650.81349186491, 18841.52896177579, 19500.1224944875, 1007.9193664506969, 1020.6121673763922, 1064.2231171245035, 1064.4837253931837, 1075.456894268405, 10051.195904327782, 10689.679309620724, 10696.732581685364, 10755.462226888782, 10758.838617420744, 397609.0, 405433.0, 405478.0, 405683.0, 406473.0, 85106.57446712727, 90294.54852725695, 90760.54619726991, 91127.0, 91605.0, 981.9558119884622, 1002.7593377589326, 1006.0643601450574, 1006.8036732837027, 1012.3622118065572, 16129.516114516584, 16527.0, 16605.50183494497, 17114.828851711325, 17343.479695609152, 39480.2103957925, 40641.39037914375, 40769.79615101906, 41394.172116558104, 41907.16185676208, 51878.74060629673, 53491.465085348646, 54381.45618543922, 56232.718836405555, 56708.43291567032, 8118.472299300526, 8266.809295536808, 8300.667973281, 8494.532800695773, 8590.0, 11738.823917641414, 12805.295708736108, 12922.676933076747, 13109.672258193621, 13150.473981040652, 10801.351918884891, 10861.78276434451, 11137.220394572627, 11303.7739245213, 12044.0, 11113.333200008025, 11447.656570302905, 11546.711332216426, 11577.884221157681, 11599.420028998686, 11354.148438866952, 11398.145139114766, 11430.142739294752, 11844.0, 11845.822312665145, 8396.87404688918, 8426.873596895928, 8480.363972701949, 8531.8720219198, 8818.823623527622, 11324.830127547928, 11326.263792853439, 11669.76660466769, 11915.76168476643, 12146.0], "value": 8809.900844985561, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.070075852213, 1500.8799296056316, 1633.175246500517, 1684.8989060656354, 1737.5569229846394, 7957.681692732283, 8193.631286592103, 8626.74119776407, 9274.489903055337, 9279.860802087975, 8755.3871229014, 9033.187013168814, 9037.63849446023, 9164.633414663422, 9182.0, 2323.6398358254455, 2331.463763334434, 2344.3787396339985, 2351.7530659280787, 2359.2568340972625, 2242.383344580245, 2275.931722048333, 2341.203990643181, 2346.6128088865316, 2348.812095032402, 2273.943151421211, 2295.8163346932206, 2299.448132448217, 2319.895604697793, 2325.360525855386, 2241.9215327463544, 2243.4839986803127, 2257.762934891829, 2259.604569200383, 2260.525289689167, 2200.834937379687, 2213.18112298449, 2219.0125394199586, 2225.0765932138142, 2227.354067320475, 8834.072422395684, 9186.219171370441, 9250.768730781718, 9277.257819374434, 9320.813583728355, 5089.949100509021, 5186.688798672054, 5191.117510023305, 5228.5555727763185, 5247.39654939683, 3241.546183534307, 3275.8034517929, 3399.55805745254, 3434.6050204226585, 3444.2422667013216, 1065.749548856026, 1073.5652060915343, 1083.4420273559124, 1098.1434481104752, 1104.1111904916538, 12797.616071517868, 12894.355282235945, 12910.483580656763, 12918.741625167539, 12951.805722914163, 4397.450318710161, 4465.933011004838, 4649.395578574764, 4691.413573303337, 4694.718316900997, 10594.57621695139, 10726.73183170427, 10757.0, 10766.300190487593, 10767.946160269148, 5129.435762066169, 5135.948640513622, 5141.691498510101, 5159.045576568347, 5205.037068142406, 4066.0, 4159.856039589137, 4541.545845415498, 4670.1126785910565, 4705.129551033001, 3773.8301776420126, 3893.0, 3976.58245884178, 3976.681865450757, 4053.3312003519677, 1258.8363512743285, 1265.9303738294482, 1302.9348532573333, 1304.8108024336418, 1309.6987692830703, 843.5402705525503, 985.4087547471603, 986.1765425869336, 988.9901100989042, 1011.5195282240877, 5923.49650279731, 6100.389961003864, 6134.8159555213415, 6150.138980542728, 6174.38256174379, 392.4270564975111, 397.7871838566353, 398.4959026831061, 403.7759043730758, 416.35465029204613, 3872.8257228424786, 3925.784081875467, 3942.802859856996, 3959.762414255154, 3968.444417781513, 10898.618548350929, 11113.444327783578, 11220.887791122148, 11306.152038597138, 11316.0, 11108.722281942855, 11202.607908723156, 11207.159463040305, 11254.38100904458, 11270.267432616854, 8414.579271036546, 8428.283595894418, 8449.915500844912, 8477.576121193915, 8496.150384961455, 5967.880642387215, 5997.370276120944, 6054.576179667381, 6061.090836374579, 6171.691415429301, 9917.107460328605, 10284.897151028394, 10429.530671119666, 10617.203709721956, 10683.30558513694, 10506.21203409732, 10604.310719803188, 10699.679009629723, 10703.464826758787, 10861.511231994737, 7005.684744186626, 7454.888176677463, 7855.37157027425, 7927.920720792949, 8054.718084867001, 8752.256058235122, 8801.075887032026, 8830.0, 8923.081537469476, 8955.149260820472, 7413.147488038944, 7525.8118547036765, 7533.434992375704, 7775.961120194363, 7824.765257042298, 7425.331720145213, 7477.70089196426, 7520.135184453858, 7606.20134885829, 7711.922880771121, 7096.8935465967015, 7205.639718014183, 7222.855542889218, 7224.638768061681, 7236.89144662841, 5136.434992150786, 5215.452377500308, 5237.214417837355, 5289.47105289468, 5481.479259470344, 5272.340957380327, 5285.0, 5306.761195746123, 5350.571954243574, 5553.722313884209], "value": 4558.39848090134, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.7738544326249, 327.78038714061586, 331.5027458811782, 337.6235497420377, 339.1047634245592, 5291.86770330741, 5440.755166017529, 5462.579729270394, 5505.752241149148, 5594.86012849679, 5213.635045546814, 5364.463553644643, 5372.355317361912, 5402.0, 5418.4039755626845, 4225.239456897757, 4237.533871274158, 4242.448481697375, 4252.744835309876, 4255.553166917475, 4157.792110394484, 4231.576842315774, 4232.534421213664, 4255.404243405926, 4270.0, 4191.580841915815, 4208.45290112285, 4209.494860616715, 4222.577742225783, 4227.112306415656, 4224.894377640569, 4227.513835908879, 4228.5560016198315, 4247.04441500663, 4266.957330426687, 3671.81640917953, 3766.9434958475645, 3771.0383852117807, 3771.4908487354132, 3774.8678796242275, 5228.816991405321, 5246.685198888041, 5256.763445644917, 5290.180022096542, 5308.416074231832, 4774.0, 4776.546228108324, 4777.4267087949665, 4791.9520804791855, 4797.136515427222, 5381.569474442035, 5616.550675945915, 5626.774929002876, 5707.058335374658, 5719.113537401709, 4020.618041286073, 4066.8373265069363, 4071.185762847442, 4083.3262511685534, 4086.4687590613325, 5948.791792287292, 5953.315368732608, 5970.761169553212, 6005.279366476051, 6010.398960103998, 3934.8622798201927, 4179.707420480538, 4194.916101677949, 4204.768737719455, 4206.978965105155, 4164.8125834337525, 4183.184279065614, 4203.5376108628025, 4206.41110244566, 4221.134667393177, 4851.840930785837, 4854.563089321978, 4871.732054737024, 4872.731999739977, 4893.678706749158, 5468.48049435303, 5759.164921086419, 5777.537796976232, 5788.913166302509, 5795.333536643256, 1441.668416264265, 1474.2260313335585, 1479.201231335067, 1479.2160155117804, 1481.3852251315584, 888.7778055486128, 926.8784770427723, 937.9155875971195, 946.1342871272846, 950.6340059077166, 4833.806647734122, 4869.22092465211, 4893.559579637778, 4913.336699545587, 4918.409790825052, 5131.794028403322, 5141.0, 5141.820036298712, 5187.443766869999, 5210.426853046162, 4753.36009076868, 4810.470848206694, 4914.91871788206, 4924.803007879645, 5025.39695236574, 2735.480258750831, 2769.587510369726, 2771.750542451189, 2775.403288293027, 2804.7518854110135, 5283.656562323436, 5341.839744807662, 5356.223347614574, 5357.5446087082255, 5378.682222855426, 4945.9968712671425, 5167.483251674803, 5212.618656056148, 5268.551148434211, 5297.629165958346, 5321.521063104339, 5331.680099194061, 5334.026410228241, 5340.359156901197, 5395.568354531628, 5193.831387937684, 5212.4005739338945, 5231.450697676842, 5232.816851410183, 5302.019126461617, 5065.3161823153405, 5462.153366228241, 5780.219670344618, 5820.185174075548, 5829.8251052468495, 6105.0, 6108.5723999319625, 6112.694365281629, 6120.17377654011, 6136.662483563447, 3921.549021862408, 4035.858744943913, 4062.2938365885807, 4137.317342638431, 4171.186618609342, 5765.538756899354, 5812.33158186797, 5814.73833677494, 5841.211436456024, 5858.765649374148, 5666.178404131296, 5751.4536119068625, 5763.550491041206, 5780.161876527964, 5820.621659592113, 5671.688057156896, 5678.4605462480995, 5693.060644993529, 5694.088945768657, 5703.663356936238, 5580.154121398197, 5599.300087489064, 5613.831585052455, 5615.0, 5644.322681278273, 5556.222008957257, 5674.943250567441, 5681.460261275172, 5682.119271512922, 5705.144228365612, 5578.493806672257, 5583.664980101207, 5604.6917419542315, 5604.747786349542, 5633.155026746021], "value": 4222.277041098206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.6087790837131, 754.6981207516992, 762.1654288554033, 762.8855671649252, 775.0002496779155, 14038.859611403883, 14828.0, 15296.464623738157, 15764.84235157648, 15829.84170158298, 16093.919530402332, 16304.83695163048, 16345.83654163461, 16393.672126557463, 16402.0, 774.4617490843838, 783.7883771381723, 794.9920500795005, 795.026093036032, 795.3239746215728, 796.1481215099845, 799.7960520067404, 801.5591424716382, 802.9919700802975, 808.9878651820227, 835.1356346181703, 840.369722707969, 841.7668116209752, 842.6671464771412, 844.9366297527679, 835.908050114487, 837.0541288344193, 838.2120806441986, 838.8532006898798, 839.5844057191699, 607.1863702638442, 608.9451949324538, 611.0284647410639, 616.2789536242607, 617.5985609353911, 14673.77989330161, 14709.190994495299, 14709.926450367786, 14783.113013219241, 14826.703465930621, 14340.713185736331, 14402.0, 14449.78325325121, 14456.204908730017, 14562.0, 11506.194566380356, 11637.0, 11761.764764704658, 11943.820842687366, 11975.22161059537, 3687.870924517656, 3700.389435743126, 3736.1033351995598, 3737.364648009845, 3737.588865224823, 76352.61823690901, 79016.60491697505, 79280.0, 79778.0, 79799.6010019952, 10783.13734901206, 10800.081993030522, 10819.513121909533, 11064.336139831636, 11080.612178573872, 18425.631487370178, 18446.446606601825, 18461.5384615383, 18471.53821154482, 18476.815231847508, 7531.284527969834, 7683.5774032427635, 7844.686212551434, 7946.364290856717, 8047.839043219103, 4687.835925742651, 4705.388299521041, 4729.95270047302, 4738.786754596052, 4888.413390393175, 3365.6802603752603, 3464.8094354810223, 3476.409010468176, 3490.3717330880177, 3491.284286721216, 593.1991811055127, 605.1437216338919, 611.9602225855305, 628.522323034497, 629.8488362792897, 541.8997485465122, 583.215575051555, 592.2241863159189, 641.9261784894703, 652.5660435810133, 9230.86153707695, 9241.445513269226, 9245.815083698288, 9295.163435290857, 9387.57755900986, 551.5229326632514, 589.4311988930702, 622.2657264428018, 643.9903401448983, 665.0523004718257, 4372.650187984954, 4421.845235416745, 4474.440694913136, 4535.886602834956, 4589.79345929434, 86878.56560717156, 87496.68860931532, 90414.54792725995, 106493.46753266185, 125337.0, 54050.45949540533, 88957.0, 91654.54172729226, 92729.0, 94135.0, 50414.243786343235, 66783.0, 82662.58668706738, 82998.58500707458, 85050.0, 8888.73333799987, 9365.62814470907, 9369.109934556207, 9467.857982130412, 9506.191973682038, 47082.0, 47133.7643311795, 49070.509294906595, 49293.098966144054, 50661.24008139807, 74731.25268747461, 75508.62245688736, 75696.0, 75783.0, 77252.0, 12409.93795031019, 12535.811962820382, 12544.435500402686, 12589.496420143092, 12677.556285529961, 14508.927455362656, 14767.630809229855, 14850.183239921907, 14869.851301486846, 15726.0, 13787.793183102061, 13935.930320348334, 13982.370793314121, 14267.857321426653, 14933.328000240233, 12747.553835615709, 12990.285534295705, 13017.739645207232, 13128.803067954179, 13377.210450852224, 13521.18872867631, 13829.10110842792, 13891.444342226197, 13912.0, 14122.418879056015, 10148.41775451746, 10449.58201671955, 10800.556217719632, 10939.398333091438, 10943.781124377627, 10084.26039761311, 10786.946065269938, 11738.237014594024, 11820.527178913091, 12084.516619335129], "value": 7286.509140481482, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 114.0, 115.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 129.0, 132.0, 169.0, 126.0, 127.0, 136.0, 124.0, 159.0, 125.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 165.0, 166.0, 167.0, 164.0, 162.0, 164.0, 163.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 114.0, 78.0, 76.0, 76.0, 75.0, 115.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 106.0, 84.0, 83.0, 84.0, 101.0, 83.0, 82.0, 106.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 146.0, 146.0, 146.0, 147.0, 147.0, 149.0, 146.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 56.0, 53.0, 56.0, 56.0, 56.0, 54.0, 54.0, 59.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 60.0, 63.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 81.0, 81.0, 84.0, 81.0, 83.0, 80.0, 81.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 133.0, 131.0, 130.0, 134.0, 147.0, 130.0, 167.0, 149.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 172.0, 169.0, 169.0, 168.0, 167.0, 171.0, 169.0, 172.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 67.0, 65.0, 66.0, 67.0, 66.0, 75.0, 66.0, 66.0, 71.0], "value": 68.3, "unit": "score"}]}]} 18:34:40 INFO - Return code: 0 18:34:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:34:40 ERROR - # TBPL SUCCESS # 18:34:40 INFO - Running post-action listener: _resource_record_post_action 18:34:40 INFO - [mozharness: 2016-10-01 01:34:40.948753Z] Finished run-tests step (success) 18:34:40 INFO - Running post-run listener: _resource_record_post_run 18:34:41 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393043968; Read time: 12; Write time: 390036 18:34:41 INFO - TinderboxPrint: CPU usage
13.4% 18:34:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:34:41 INFO - TinderboxPrint: I/O write bytes / time
393,043,968 / 390,036 18:34:41 INFO - TinderboxPrint: CPU idle
8,253.8 (86.5%) 18:34:41 INFO - TinderboxPrint: CPU user
1,218.7 (12.8%) 18:34:41 INFO - TinderboxPrint: Swap in / out
0 / 0 18:34:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103841792; Read time: 0; Write time: 147800 18:34:41 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289202176; Read time: 0; Write time: 242236 18:34:41 INFO - Running post-run listener: _upload_blobber_files 18:34:41 INFO - Blob upload gear active. 18:34:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:34:41 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 18:34:41 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:34:41 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:34:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:34:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:34:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:34:42 INFO - (blobuploader) - INFO - Done attempting. 18:34:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:34:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:34:45 INFO - (blobuploader) - INFO - Done attempting. 18:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:34:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:34:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:34:46 INFO - (blobuploader) - INFO - Done attempting. 18:34:46 INFO - (blobuploader) - INFO - Iteration through files over. 18:34:46 INFO - Return code: 0 18:34:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:34:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:34:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/511ea9407b0122d4e37e7cb5c0c7458db9834fbb33d0a36878328e3396b1c18c0c3def8b7a2196a28e64faa0c4eb74f1f3a2ea2982585c10791e985797929e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d96831f89677e5367fc6cfd666ed7ace798cfd77c9cfa88c915a3624d4ad5fa4e05006422210c5ed461249cd79cf1d4e79f25f6634ce980c1d09d5f6bbeea5a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f41505bd8fb2e5403e30d08a48d2ddf60e3e3359707a0f6ff1a67262de86d487ef34daa9a1db57d6b735ff135eb4ead08281278190f5dcbe939e1933f056264"} 18:34:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:34:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:34:46 INFO - Contents: 18:34:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/511ea9407b0122d4e37e7cb5c0c7458db9834fbb33d0a36878328e3396b1c18c0c3def8b7a2196a28e64faa0c4eb74f1f3a2ea2982585c10791e985797929e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d96831f89677e5367fc6cfd666ed7ace798cfd77c9cfa88c915a3624d4ad5fa4e05006422210c5ed461249cd79cf1d4e79f25f6634ce980c1d09d5f6bbeea5a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f41505bd8fb2e5403e30d08a48d2ddf60e3e3359707a0f6ff1a67262de86d487ef34daa9a1db57d6b735ff135eb4ead08281278190f5dcbe939e1933f056264"} 18:34:46 INFO - Running post-run listener: copy_logs_to_upload_dir 18:34:46 INFO - Copying logs to upload dir... 18:34:46 INFO - mkdir: /builds/slave/test/build/upload/logs 18:34:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.571794 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-30 18:34:45.235586) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 18:34:45.239607) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/511ea9407b0122d4e37e7cb5c0c7458db9834fbb33d0a36878328e3396b1c18c0c3def8b7a2196a28e64faa0c4eb74f1f3a2ea2982585c10791e985797929e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d96831f89677e5367fc6cfd666ed7ace798cfd77c9cfa88c915a3624d4ad5fa4e05006422210c5ed461249cd79cf1d4e79f25f6634ce980c1d09d5f6bbeea5a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f41505bd8fb2e5403e30d08a48d2ddf60e3e3359707a0f6ff1a67262de86d487ef34daa9a1db57d6b735ff135eb4ead08281278190f5dcbe939e1933f056264"} build_url:https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://queue.taskcluster.net/v1/task/MdaL99leSMubGELMRyoT_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/511ea9407b0122d4e37e7cb5c0c7458db9834fbb33d0a36878328e3396b1c18c0c3def8b7a2196a28e64faa0c4eb74f1f3a2ea2982585c10791e985797929e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d96831f89677e5367fc6cfd666ed7ace798cfd77c9cfa88c915a3624d4ad5fa4e05006422210c5ed461249cd79cf1d4e79f25f6634ce980c1d09d5f6bbeea5a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f41505bd8fb2e5403e30d08a48d2ddf60e3e3359707a0f6ff1a67262de86d487ef34daa9a1db57d6b735ff135eb4ead08281278190f5dcbe939e1933f056264"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 18:34:45.264779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:34:45.265165) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475283673.704374-877731281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 18:34:45.354061) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 18:34:45.354807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 18:34:45.355524) ========= ========= Total master_lag: 0.16 =========