builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1466170086.31 results: success (0) buildid: 20160617053224 builduid: b58e494dee9646349a8d9d3c68e61f9c revision: 535a13bd2bf94fcc72d7e2432100fba85f7c322a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 06:28:06.305436) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 06:28:06.305990) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-06-17 06:28:06.306271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-06-17 06:28:09.114708) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:28:09.115034) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 06:28:09-- 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% 32.9M=0s 2016-06-17 06:28:09 (32.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091339 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:28:09.338617) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:28:09.338951) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016729 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:28:09.410485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-17 06:28:09.410858) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 535a13bd2bf94fcc72d7e2432100fba85f7c322a --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 535a13bd2bf94fcc72d7e2432100fba85f7c322a --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=9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 06:28:09,746 truncating revision to first 12 chars 2016-06-17 06:28:09,746 Setting DEBUG logging. 2016-06-17 06:28:09,746 attempt 1/10 2016-06-17 06:28:09,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/535a13bd2bf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 06:28:10,700 unpacking tar archive at: fx-team-535a13bd2bf9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.320721 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-17 06:28:10.745866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 06:28:10.746252) ========= script_repo_revision: 535a13bd2bf94fcc72d7e2432100fba85f7c322a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 06:28:10.746697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 06:28:10.746973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 06:28:10.758878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-17 06:28:10.759277) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:28:11 INFO - MultiFileLogger online at 20160617 06:28:11 in /builds/slave/test 06:28:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:28:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:28:11 INFO - {'append_to_log': False, 06:28:11 INFO - 'base_work_dir': '/builds/slave/test', 06:28:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:28:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:28:11 INFO - 'branch': 'Fx-Team-Non-PGO', 06:28:11 INFO - 'buildbot_json_path': 'buildprops.json', 06:28:11 INFO - 'config_files': ('talos/linux_config.py',), 06:28:11 INFO - 'default_actions': ('clobber', 06:28:11 INFO - 'read-buildbot-config', 06:28:11 INFO - 'download-and-extract', 06:28:11 INFO - 'populate-webroot', 06:28:11 INFO - 'create-virtualenv', 06:28:11 INFO - 'install', 06:28:11 INFO - 'run-tests'), 06:28:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:28:11 INFO - 'download_minidump_stackwalk': True, 06:28:11 INFO - 'download_symbols': 'ondemand', 06:28:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:28:11 INFO - 'tooltool.py': '/tools/tooltool.py', 06:28:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:28:11 INFO - '/tools/misc-python/virtualenv.py')}, 06:28:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:28:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:28:11 INFO - 'installer_path': 'installer.exe', 06:28:11 INFO - 'log_level': 'info', 06:28:11 INFO - 'log_name': 'talos', 06:28:11 INFO - 'log_to_console': True, 06:28:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:28:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:28:11 INFO - 'opt_config_files': (), 06:28:11 INFO - 'pip_index': False, 06:28:11 INFO - 'sps_profile': False, 06:28:11 INFO - 'sps_profile_interval': 0, 06:28:11 INFO - 'suite': 'dromaeojs-e10s', 06:28:11 INFO - 'system_bits': '32', 06:28:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:28:11 INFO - 'title': 'talos-linux64-ix-013', 06:28:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:28:11 INFO - 'use_talos_json': True, 06:28:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:28:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:28:11 INFO - 'work_dir': 'build'} 06:28:11 INFO - ##### 06:28:11 INFO - ##### Running clobber step. 06:28:11 INFO - ##### 06:28:11 INFO - Running pre-action listener: _resource_record_pre_action 06:28:11 INFO - Running main action method: clobber 06:28:11 INFO - rmtree: /builds/slave/test/build 06:28:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:28:12 INFO - Running post-action listener: _resource_record_post_action 06:28:12 INFO - ##### 06:28:12 INFO - ##### Finished clobber step (success) 06:28:12 INFO - ##### 06:28:12 INFO - ##### 06:28:12 INFO - ##### Running read-buildbot-config step. 06:28:12 INFO - ##### 06:28:12 INFO - Running pre-action listener: _resource_record_pre_action 06:28:12 INFO - Running main action method: read_buildbot_config 06:28:12 INFO - Using buildbot properties: 06:28:12 INFO - { 06:28:12 INFO - "project": "", 06:28:12 INFO - "product": "firefox", 06:28:12 INFO - "script_repo_revision": "production", 06:28:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:28:12 INFO - "repository": "", 06:28:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:28:12 INFO - "buildid": "20160617053224", 06:28:12 INFO - "pgo_build": "False", 06:28:12 INFO - "basedir": "/builds/slave/test", 06:28:12 INFO - "buildnumber": 1373, 06:28:12 INFO - "slavename": "talos-linux64-ix-013", 06:28:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:28:12 INFO - "platform": "ubuntu64_hw", 06:28:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:28:12 INFO - "branch": "fx-team", 06:28:12 INFO - "repo_path": "integration/fx-team", 06:28:12 INFO - "revision": "535a13bd2bf94fcc72d7e2432100fba85f7c322a", 06:28:12 INFO - "stage_platform": "linux64", 06:28:12 INFO - "builduid": "b58e494dee9646349a8d9d3c68e61f9c", 06:28:12 INFO - "slavebuilddir": "test" 06:28:12 INFO - } 06:28:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:28:12 INFO - Running post-action listener: _resource_record_post_action 06:28:12 INFO - ##### 06:28:12 INFO - ##### Finished read-buildbot-config step (success) 06:28:12 INFO - ##### 06:28:12 INFO - ##### 06:28:12 INFO - ##### Running download-and-extract step. 06:28:12 INFO - ##### 06:28:12 INFO - Running pre-action listener: _resource_record_pre_action 06:28:12 INFO - Running main action method: download_and_extract 06:28:12 INFO - mkdir: /builds/slave/test/build/tests 06:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:12 INFO - https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:28:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:28:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:28:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:28:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:28:12 INFO - Downloaded 1361 bytes. 06:28:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:28:12 INFO - Using the following test package requirements: 06:28:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:28:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:28:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:28:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:12 INFO - u'jsshell-linux-x86_64.zip'], 06:28:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:28:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:28:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:28:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:28:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:28:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:28:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:12 INFO - https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:28:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:28:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:28:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:28:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:28:15 INFO - Downloaded 22654592 bytes. 06:28:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:28:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:28:16 INFO - Return code: 0 06:28:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:16 INFO - https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:28:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:28:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:28:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:28:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:28:17 INFO - Downloaded 22654592 bytes. 06:28:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:28:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:28:18 INFO - Return code: 0 06:28:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:18 INFO - https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:28:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:28:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:28:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:28:20 INFO - Downloaded 14405384 bytes. 06:28:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:28:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:28:21 INFO - Return code: 0 06:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:21 INFO - https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:28:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:28:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:28:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:28:22 INFO - Downloaded 55449583 bytes. 06:28:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:28:22 INFO - mkdir: /builds/slave/test/properties 06:28:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:28:22 INFO - Writing to file /builds/slave/test/properties/build_url 06:28:22 INFO - Contents: 06:28:22 INFO - build_url:https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:28:23 INFO - Running post-action listener: _resource_record_post_action 06:28:23 INFO - Running post-action listener: set_extra_try_arguments 06:28:23 INFO - ##### 06:28:23 INFO - ##### Finished download-and-extract step (success) 06:28:23 INFO - ##### 06:28:23 INFO - ##### 06:28:23 INFO - ##### Running populate-webroot step. 06:28:23 INFO - ##### 06:28:23 INFO - Running pre-action listener: _resource_record_pre_action 06:28:23 INFO - Running main action method: populate_webroot 06:28:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:28:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:28:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:28:23 INFO - '--tppagecycles', 06:28:23 INFO - '7'], 06:28:23 INFO - 'tests': ['tsvgm']}}, 06:28:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:28:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:28:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:28:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:28:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:23 INFO - 'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:23 INFO - 'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['damp', 'tps']}, 06:28:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:23 INFO - 'tests': ['damp', 'tps']}, 06:28:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['dromaeo_dom']}, 06:28:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:28:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['basic_compositor_video']}, 06:28:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:28:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['a11yr', 06:28:23 INFO - 'ts_paint', 06:28:23 INFO - 'tpaint', 06:28:23 INFO - 'sessionrestore', 06:28:23 INFO - 'sessionrestore_no_auto_restore', 06:28:23 INFO - 'tabpaint']}, 06:28:23 INFO - 'other-e10s': {'tests': ['a11yr', 06:28:23 INFO - 'ts_paint', 06:28:23 INFO - 'tpaint', 06:28:23 INFO - 'sessionrestore', 06:28:23 INFO - 'sessionrestore_no_auto_restore', 06:28:23 INFO - 'tabpaint']}, 06:28:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:28:23 INFO - 'ts_paint', 06:28:23 INFO - 'tpaint', 06:28:23 INFO - 'sessionrestore', 06:28:23 INFO - 'sessionrestore_no_auto_restore', 06:28:23 INFO - 'tabpaint']}, 06:28:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:28:23 INFO - 'ts_paint', 06:28:23 INFO - 'tpaint', 06:28:23 INFO - 'sessionrestore', 06:28:23 INFO - 'sessionrestore_no_auto_restore', 06:28:23 INFO - 'tabpaint']}, 06:28:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['a11yr', 06:28:23 INFO - 'ts_paint', 06:28:23 INFO - 'tpaint', 06:28:23 INFO - 'sessionrestore', 06:28:23 INFO - 'sessionrestore_no_auto_restore', 06:28:23 INFO - 'tabpaint']}, 06:28:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['a11yr', 06:28:23 INFO - 'ts_paint', 06:28:23 INFO - 'tpaint', 06:28:23 INFO - 'sessionrestore', 06:28:23 INFO - 'sessionrestore_no_auto_restore', 06:28:23 INFO - 'tabpaint']}, 06:28:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['tsvgx', 06:28:23 INFO - 'tsvgr_opacity', 06:28:23 INFO - 'tart', 06:28:23 INFO - 'tscrollx', 06:28:23 INFO - 'cart']}, 06:28:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:28:23 INFO - 'tsvgr_opacity', 06:28:23 INFO - 'tart', 06:28:23 INFO - 'tscrollx', 06:28:23 INFO - 'cart']}, 06:28:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:23 INFO - 'talos_options': ['--disable-e10s'], 06:28:23 INFO - 'tests': ['tp5o']}, 06:28:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:23 INFO - 'tests': ['tp5o']}, 06:28:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:23 INFO - 'talos_options': ['--disable-e10s', 06:28:23 INFO - '--xperf_path', 06:28:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:23 INFO - 'tests': ['tp5n']}, 06:28:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:23 INFO - 'talos_options': ['--xperf_path', 06:28:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:23 INFO - 'tests': ['tp5n']}}, 06:28:23 INFO - 'talos.zip': {'path': '', 06:28:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:28:23 INFO - Running post-action listener: _resource_record_post_action 06:28:23 INFO - ##### 06:28:23 INFO - ##### Finished populate-webroot step (success) 06:28:23 INFO - ##### 06:28:23 INFO - ##### 06:28:23 INFO - ##### Running create-virtualenv step. 06:28:23 INFO - ##### 06:28:23 INFO - Running pre-action listener: _resource_record_pre_action 06:28:23 INFO - Running main action method: create_virtualenv 06:28:23 INFO - Creating virtualenv /builds/slave/test/build/venv 06:28:23 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 06:28:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:28:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:28:23 INFO - Using real prefix '/usr' 06:28:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:28:24 INFO - Installing distribute.............................................................................................................................................................................................done. 06:28:26 INFO - Installing pip.................done. 06:28:26 INFO - Return code: 0 06:28:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:28:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:26 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 0x7f421d001f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', '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 06:28:26 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 06:28:26 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 06:28:26 INFO - Using env: {'DISPLAY': ':0', 06:28:26 INFO - 'HOME': '/home/cltbld', 06:28:26 INFO - 'LANG': 'en_US.UTF-8', 06:28:26 INFO - 'LANGUAGE': 'en_US:en', 06:28:26 INFO - 'LOGNAME': 'cltbld', 06:28:26 INFO - 'MAIL': '/var/mail/cltbld', 06:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:26 INFO - 'MOZ_NO_REMOTE': '1', 06:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:26 INFO - 'NO_EM_RESTART': '1', 06:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:26 INFO - 'PWD': '/builds/slave/test', 06:28:26 INFO - 'SHELL': '/bin/bash', 06:28:26 INFO - 'SHLVL': '1', 06:28:26 INFO - 'TERM': 'linux', 06:28:26 INFO - 'TMOUT': '86400', 06:28:26 INFO - 'USER': 'cltbld', 06:28:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:26 INFO - '_': '/tools/buildbot/bin/python'} 06:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:26 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 06:28:26 INFO - Cleaning up... 06:28:26 INFO - Return code: 0 06:28:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:28:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:26 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 0x7f421d001f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', '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 06:28:26 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 06:28:26 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 06:28:26 INFO - Using env: {'DISPLAY': ':0', 06:28:26 INFO - 'HOME': '/home/cltbld', 06:28:26 INFO - 'LANG': 'en_US.UTF-8', 06:28:26 INFO - 'LANGUAGE': 'en_US:en', 06:28:26 INFO - 'LOGNAME': 'cltbld', 06:28:26 INFO - 'MAIL': '/var/mail/cltbld', 06:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:26 INFO - 'MOZ_NO_REMOTE': '1', 06:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:26 INFO - 'NO_EM_RESTART': '1', 06:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:26 INFO - 'PWD': '/builds/slave/test', 06:28:26 INFO - 'SHELL': '/bin/bash', 06:28:26 INFO - 'SHLVL': '1', 06:28:26 INFO - 'TERM': 'linux', 06:28:26 INFO - 'TMOUT': '86400', 06:28:26 INFO - 'USER': 'cltbld', 06:28:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:26 INFO - '_': '/tools/buildbot/bin/python'} 06:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:26 INFO - Downloading/unpacking psutil>=3.1.1 06:28:26 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 06:28:26 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 06:28:26 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 06:28:26 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 06:28:26 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 06:28:26 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 06:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:28:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:28 INFO - Installing collected packages: psutil 06:28:28 INFO - Running setup.py install for psutil 06:28:28 INFO - building 'psutil._psutil_linux' extension 06:28:28 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 06:28:29 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 06:28:29 INFO - building 'psutil._psutil_posix' extension 06:28:29 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 06:28:29 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 06:28:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:29 INFO - Successfully installed psutil 06:28:29 INFO - Cleaning up... 06:28:29 INFO - Return code: 0 06:28:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f421d001f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', '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 06:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:28:29 INFO - Using env: {'DISPLAY': ':0', 06:28:29 INFO - 'HOME': '/home/cltbld', 06:28:29 INFO - 'LANG': 'en_US.UTF-8', 06:28:29 INFO - 'LANGUAGE': 'en_US:en', 06:28:29 INFO - 'LOGNAME': 'cltbld', 06:28:29 INFO - 'MAIL': '/var/mail/cltbld', 06:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:29 INFO - 'MOZ_NO_REMOTE': '1', 06:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:29 INFO - 'NO_EM_RESTART': '1', 06:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:29 INFO - 'PWD': '/builds/slave/test', 06:28:29 INFO - 'SHELL': '/bin/bash', 06:28:29 INFO - 'SHLVL': '1', 06:28:29 INFO - 'TERM': 'linux', 06:28:29 INFO - 'TMOUT': '86400', 06:28:29 INFO - 'USER': 'cltbld', 06:28:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:29 INFO - '_': '/tools/buildbot/bin/python'} 06:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:28:31 INFO - Installing collected packages: mozsystemmonitor 06:28:31 INFO - Running setup.py install for mozsystemmonitor 06:28:31 INFO - Successfully installed mozsystemmonitor 06:28:31 INFO - Cleaning up... 06:28:31 INFO - Return code: 0 06:28:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f421d001f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', '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 06:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:28:31 INFO - Using env: {'DISPLAY': ':0', 06:28:31 INFO - 'HOME': '/home/cltbld', 06:28:31 INFO - 'LANG': 'en_US.UTF-8', 06:28:31 INFO - 'LANGUAGE': 'en_US:en', 06:28:31 INFO - 'LOGNAME': 'cltbld', 06:28:31 INFO - 'MAIL': '/var/mail/cltbld', 06:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:31 INFO - 'MOZ_NO_REMOTE': '1', 06:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:31 INFO - 'NO_EM_RESTART': '1', 06:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:31 INFO - 'PWD': '/builds/slave/test', 06:28:31 INFO - 'SHELL': '/bin/bash', 06:28:31 INFO - 'SHLVL': '1', 06:28:31 INFO - 'TERM': 'linux', 06:28:31 INFO - 'TMOUT': '86400', 06:28:31 INFO - 'USER': 'cltbld', 06:28:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:31 INFO - '_': '/tools/buildbot/bin/python'} 06:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:32 INFO - Downloading/unpacking jsonschema==2.5.1 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:28:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:34 INFO - Downloading functools32-3.2.3-2.tar.gz 06:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:28:34 INFO - warning: no files found matching '*.txt' 06:28:34 INFO - no previously-included directories found matching 'build' 06:28:34 INFO - no previously-included directories found matching 'dist' 06:28:34 INFO - no previously-included directories found matching '.git*' 06:28:34 INFO - Installing collected packages: jsonschema, functools32 06:28:34 INFO - Running setup.py install for functools32 06:28:35 INFO - warning: no files found matching '*.txt' 06:28:35 INFO - no previously-included directories found matching 'build' 06:28:35 INFO - no previously-included directories found matching 'dist' 06:28:35 INFO - no previously-included directories found matching '.git*' 06:28:35 INFO - Successfully installed jsonschema functools32 06:28:35 INFO - Cleaning up... 06:28:35 INFO - Return code: 0 06:28:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f421d001f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', '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 06:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:28:35 INFO - Using env: {'DISPLAY': ':0', 06:28:35 INFO - 'HOME': '/home/cltbld', 06:28:35 INFO - 'LANG': 'en_US.UTF-8', 06:28:35 INFO - 'LANGUAGE': 'en_US:en', 06:28:35 INFO - 'LOGNAME': 'cltbld', 06:28:35 INFO - 'MAIL': '/var/mail/cltbld', 06:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:35 INFO - 'MOZ_NO_REMOTE': '1', 06:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:35 INFO - 'NO_EM_RESTART': '1', 06:28:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:35 INFO - 'PWD': '/builds/slave/test', 06:28:35 INFO - 'SHELL': '/bin/bash', 06:28:35 INFO - 'SHLVL': '1', 06:28:35 INFO - 'TERM': 'linux', 06:28:35 INFO - 'TMOUT': '86400', 06:28:35 INFO - 'USER': 'cltbld', 06:28:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:35 INFO - '_': '/tools/buildbot/bin/python'} 06:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:35 INFO - Downloading/unpacking blobuploader==1.2.4 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:37 INFO - Downloading blobuploader-1.2.4.tar.gz 06:28:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:28:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:28:37 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 06:28:37 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 06:28:37 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 06:28:37 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 06:28:37 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 06:28:37 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 06:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:28:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:38 INFO - Downloading docopt-0.6.1.tar.gz 06:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:28:38 INFO - Installing collected packages: blobuploader, requests, docopt 06:28:38 INFO - Running setup.py install for blobuploader 06:28:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:28:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:28:38 INFO - Running setup.py install for requests 06:28:39 INFO - Running setup.py install for docopt 06:28:39 INFO - Successfully installed blobuploader requests docopt 06:28:39 INFO - Cleaning up... 06:28:39 INFO - Return code: 0 06:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f421d001f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', '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 06:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:28:39 INFO - Using env: {'DISPLAY': ':0', 06:28:39 INFO - 'HOME': '/home/cltbld', 06:28:39 INFO - 'LANG': 'en_US.UTF-8', 06:28:39 INFO - 'LANGUAGE': 'en_US:en', 06:28:39 INFO - 'LOGNAME': 'cltbld', 06:28:39 INFO - 'MAIL': '/var/mail/cltbld', 06:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:39 INFO - 'MOZ_NO_REMOTE': '1', 06:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:39 INFO - 'NO_EM_RESTART': '1', 06:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:39 INFO - 'PWD': '/builds/slave/test', 06:28:39 INFO - 'SHELL': '/bin/bash', 06:28:39 INFO - 'SHLVL': '1', 06:28:39 INFO - 'TERM': 'linux', 06:28:39 INFO - 'TMOUT': '86400', 06:28:39 INFO - 'USER': 'cltbld', 06:28:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:39 INFO - '_': '/tools/buildbot/bin/python'} 06:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:39 INFO - Running setup.py (path:/tmp/pip-11tVkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:39 INFO - Running setup.py (path:/tmp/pip-BZE8O_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:39 INFO - Running setup.py (path:/tmp/pip-CjSzhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:39 INFO - Running setup.py (path:/tmp/pip-27nxcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:39 INFO - Running setup.py (path:/tmp/pip-VYj8gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:39 INFO - Running setup.py (path:/tmp/pip-yovbyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:39 INFO - Running setup.py (path:/tmp/pip-39zr8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:39 INFO - Running setup.py (path:/tmp/pip-jlKtKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:39 INFO - Running setup.py (path:/tmp/pip-IsSQ88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:40 INFO - Running setup.py (path:/tmp/pip-Kho6rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:40 INFO - Running setup.py (path:/tmp/pip-3RA8Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:40 INFO - Running setup.py (path:/tmp/pip-kftU82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:40 INFO - Running setup.py (path:/tmp/pip-YmLv2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:40 INFO - Running setup.py (path:/tmp/pip-NvrDqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:40 INFO - Running setup.py (path:/tmp/pip-72JvlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:40 INFO - Running setup.py (path:/tmp/pip-uMk4Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:40 INFO - Running setup.py (path:/tmp/pip-Jygk3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:28:40 INFO - Running setup.py install for manifestparser 06:28:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:28:40 INFO - Running setup.py install for mozcrash 06:28:40 INFO - Running setup.py install for mozdebug 06:28:40 INFO - Running setup.py install for mozdevice 06:28:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Running setup.py install for mozfile 06:28:41 INFO - Running setup.py install for mozhttpd 06:28:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Running setup.py install for mozinfo 06:28:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Running setup.py install for mozInstall 06:28:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Running setup.py install for mozleak 06:28:41 INFO - Running setup.py install for mozlog 06:28:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Running setup.py install for moznetwork 06:28:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Running setup.py install for mozprocess 06:28:41 INFO - Running setup.py install for mozprofile 06:28:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:28:41 INFO - Running setup.py install for mozrunner 06:28:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:28:42 INFO - Running setup.py install for mozscreenshot 06:28:42 INFO - Running setup.py install for moztest 06:28:42 INFO - Running setup.py install for mozversion 06:28:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:28:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:28:42 INFO - Cleaning up... 06:28:42 INFO - Return code: 0 06:28:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f421d001f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', '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 06:28:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:28:42 INFO - Using env: {'DISPLAY': ':0', 06:28:42 INFO - 'HOME': '/home/cltbld', 06:28:42 INFO - 'LANG': 'en_US.UTF-8', 06:28:42 INFO - 'LANGUAGE': 'en_US:en', 06:28:42 INFO - 'LOGNAME': 'cltbld', 06:28:42 INFO - 'MAIL': '/var/mail/cltbld', 06:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:42 INFO - 'MOZ_NO_REMOTE': '1', 06:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:42 INFO - 'NO_EM_RESTART': '1', 06:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:42 INFO - 'PWD': '/builds/slave/test', 06:28:42 INFO - 'SHELL': '/bin/bash', 06:28:42 INFO - 'SHLVL': '1', 06:28:42 INFO - 'TERM': 'linux', 06:28:42 INFO - 'TMOUT': '86400', 06:28:42 INFO - 'USER': 'cltbld', 06:28:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:42 INFO - '_': '/tools/buildbot/bin/python'} 06:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:42 INFO - Running setup.py (path:/tmp/pip-dzhD1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:42 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)) 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:42 INFO - Running setup.py (path:/tmp/pip-XupBD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:42 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)) 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:42 INFO - Running setup.py (path:/tmp/pip-CUIwo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:42 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)) 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:42 INFO - Running setup.py (path:/tmp/pip-ci4J9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:42 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)) 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:42 INFO - Running setup.py (path:/tmp/pip-ROSz39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:42 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)) 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:42 INFO - Running setup.py (path:/tmp/pip-wq5HIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:43 INFO - Running setup.py (path:/tmp/pip-YM6u40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:43 INFO - Running setup.py (path:/tmp/pip-TBmEPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:43 INFO - Running setup.py (path:/tmp/pip-2afWkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:43 INFO - Running setup.py (path:/tmp/pip-SO_Tha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:43 INFO - Running setup.py (path:/tmp/pip-dp6oje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:43 INFO - Running setup.py (path:/tmp/pip-h9EIyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:43 INFO - Running setup.py (path:/tmp/pip-Mn7_HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:43 INFO - Running setup.py (path:/tmp/pip-PAssKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:43 INFO - Running setup.py (path:/tmp/pip-G7RZFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:43 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)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:43 INFO - Running setup.py (path:/tmp/pip-609YGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:43 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)) 06:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:43 INFO - Running setup.py (path:/tmp/pip-n6NFbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:43 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)) 06:28:43 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)) 06:28:43 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)) 06:28:43 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)) 06:28:43 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)) 06:28:43 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)) 06:28:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:46 INFO - Downloading blessings-1.6.tar.gz 06:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:28:46 INFO - Installing collected packages: blessings 06:28:46 INFO - Running setup.py install for blessings 06:28:46 INFO - Successfully installed blessings 06:28:46 INFO - Cleaning up... 06:28:46 INFO - Return code: 0 06:28:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:46 INFO - Reading from file tmpfile_stdout 06:28:46 INFO - Current package versions: 06:28:46 INFO - argparse == 1.2.1 06:28:46 INFO - blessings == 1.6 06:28:46 INFO - blobuploader == 1.2.4 06:28:46 INFO - docopt == 0.6.1 06:28:46 INFO - functools32 == 3.2.3-2 06:28:46 INFO - jsonschema == 2.5.1 06:28:46 INFO - manifestparser == 1.1 06:28:46 INFO - mozInstall == 1.12 06:28:46 INFO - mozcrash == 0.17 06:28:46 INFO - mozdebug == 0.1 06:28:46 INFO - mozdevice == 0.48 06:28:46 INFO - mozfile == 1.2 06:28:46 INFO - mozhttpd == 0.7 06:28:46 INFO - mozinfo == 0.9 06:28:46 INFO - mozleak == 0.1 06:28:46 INFO - mozlog == 3.2 06:28:46 INFO - moznetwork == 0.27 06:28:46 INFO - mozprocess == 0.22 06:28:46 INFO - mozprofile == 0.28 06:28:46 INFO - mozrunner == 6.11 06:28:46 INFO - mozscreenshot == 0.1 06:28:46 INFO - mozsystemmonitor == 0.3 06:28:46 INFO - moztest == 0.7 06:28:46 INFO - mozversion == 1.4 06:28:46 INFO - psutil == 3.1.1 06:28:46 INFO - requests == 1.2.3 06:28:46 INFO - wsgiref == 0.1.2 06:28:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f421d001f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', '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 06:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:28:46 INFO - Using env: {'DISPLAY': ':0', 06:28:46 INFO - 'HOME': '/home/cltbld', 06:28:46 INFO - 'LANG': 'en_US.UTF-8', 06:28:46 INFO - 'LANGUAGE': 'en_US:en', 06:28:46 INFO - 'LOGNAME': 'cltbld', 06:28:46 INFO - 'MAIL': '/var/mail/cltbld', 06:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:46 INFO - 'MOZ_NO_REMOTE': '1', 06:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:46 INFO - 'NO_EM_RESTART': '1', 06:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:46 INFO - 'PWD': '/builds/slave/test', 06:28:46 INFO - 'SHELL': '/bin/bash', 06:28:46 INFO - 'SHLVL': '1', 06:28:46 INFO - 'TERM': 'linux', 06:28:46 INFO - 'TMOUT': '86400', 06:28:46 INFO - 'USER': 'cltbld', 06:28:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:46 INFO - '_': '/tools/buildbot/bin/python'} 06:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:28:46 INFO - Cleaning up... 06:28:46 INFO - Return code: 0 06:28:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f421d001f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', '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 06:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:28:46 INFO - Using env: {'DISPLAY': ':0', 06:28:46 INFO - 'HOME': '/home/cltbld', 06:28:46 INFO - 'LANG': 'en_US.UTF-8', 06:28:46 INFO - 'LANGUAGE': 'en_US:en', 06:28:46 INFO - 'LOGNAME': 'cltbld', 06:28:46 INFO - 'MAIL': '/var/mail/cltbld', 06:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:46 INFO - 'MOZ_NO_REMOTE': '1', 06:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:46 INFO - 'NO_EM_RESTART': '1', 06:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:46 INFO - 'PWD': '/builds/slave/test', 06:28:46 INFO - 'SHELL': '/bin/bash', 06:28:46 INFO - 'SHLVL': '1', 06:28:46 INFO - 'TERM': 'linux', 06:28:46 INFO - 'TMOUT': '86400', 06:28:46 INFO - 'USER': 'cltbld', 06:28:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:46 INFO - '_': '/tools/buildbot/bin/python'} 06:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:28:47 INFO - Cleaning up... 06:28:47 INFO - Return code: 0 06:28:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:28:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:47 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f421d001f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', '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 06:28:47 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', 'flake8'] in /builds/slave/test/build 06:28:47 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 flake8 06:28:47 INFO - Using env: {'DISPLAY': ':0', 06:28:47 INFO - 'HOME': '/home/cltbld', 06:28:47 INFO - 'LANG': 'en_US.UTF-8', 06:28:47 INFO - 'LANGUAGE': 'en_US:en', 06:28:47 INFO - 'LOGNAME': 'cltbld', 06:28:47 INFO - 'MAIL': '/var/mail/cltbld', 06:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:47 INFO - 'MOZ_NO_REMOTE': '1', 06:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:47 INFO - 'NO_EM_RESTART': '1', 06:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:47 INFO - 'PWD': '/builds/slave/test', 06:28:47 INFO - 'SHELL': '/bin/bash', 06:28:47 INFO - 'SHLVL': '1', 06:28:47 INFO - 'TERM': 'linux', 06:28:47 INFO - 'TMOUT': '86400', 06:28:47 INFO - 'USER': 'cltbld', 06:28:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:47 INFO - '_': '/tools/buildbot/bin/python'} 06:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:47 INFO - Downloading/unpacking flake8 06:28:47 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 06:28:47 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 06:28:47 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 06:28:47 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 06:28:47 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 06:28:47 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 06:28:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:28:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:28:49 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 06:28:49 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 06:28:49 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 06:28:49 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 06:28:49 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 06:28:49 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 06:28:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:28:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:28:49 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 06:28:49 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 06:28:49 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 06:28:49 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 06:28:49 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 06:28:49 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 06:28:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:28:50 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 06:28:50 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 06:28:50 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 06:28:50 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 06:28:50 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 06:28:50 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 06:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:50 INFO - no previously-included directories found matching 'docs/_build' 06:28:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:28:50 INFO - Running setup.py install for pep8 06:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:50 INFO - no previously-included directories found matching 'docs/_build' 06:28:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:28:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:28:50 INFO - Cleaning up... 06:28:50 INFO - Return code: 0 06:28:50 INFO - Running post-action listener: _resource_record_post_action 06:28:50 INFO - Running post-action listener: _start_resource_monitoring 06:28:50 INFO - Starting resource monitoring. 06:28:50 INFO - ##### 06:28:50 INFO - ##### Finished create-virtualenv step (success) 06:28:50 INFO - ##### 06:28:50 INFO - ##### 06:28:50 INFO - ##### Running install step. 06:28:50 INFO - ##### 06:28:50 INFO - Running pre-action listener: _resource_record_pre_action 06:28:50 INFO - Running main action method: install 06:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:50 INFO - Reading from file tmpfile_stdout 06:28:50 INFO - Detecting whether we're running mozinstall >=1.0... 06:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:28:50 INFO - Reading from file tmpfile_stdout 06:28:50 INFO - Output received: 06:28:50 INFO - Usage: mozinstall [options] installer 06:28:50 INFO - Options: 06:28:50 INFO - -h, --help show this help message and exit 06:28:50 INFO - -d DEST, --destination=DEST 06:28:50 INFO - Directory to install application into. [default: 06:28:50 INFO - "/builds/slave/test"] 06:28:50 INFO - --app=APP Application being installed. [default: firefox] 06:28:50 INFO - mkdir: /builds/slave/test/build/application 06:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:29:06 INFO - Reading from file tmpfile_stdout 06:29:06 INFO - Output received: 06:29:06 INFO - /builds/slave/test/build/application/firefox/firefox 06:29:06 INFO - Running post-action listener: _resource_record_post_action 06:29:06 INFO - ##### 06:29:06 INFO - ##### Finished install step (success) 06:29:06 INFO - ##### 06:29:06 INFO - ##### 06:29:06 INFO - ##### Running run-tests step. 06:29:06 INFO - ##### 06:29:06 INFO - Running pre-action listener: _resource_record_pre_action 06:29:06 INFO - Running main action method: run_tests 06:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:29:06 INFO - Python 2.7.3 06:29:06 INFO - Return code: 0 06:29:06 INFO - grabbing minidump binary from tooltool 06:29:06 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:06 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 0x19962e0>, '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 0x1902140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19025d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:29:06 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 06:29:06 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 06:29:06 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 06:29:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:29:07 INFO - Return code: 0 06:29:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:29:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:29:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:29:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:29:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:29:07 INFO - Return code: 0 06:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 06:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 06:29:07 INFO - Using env: {'DISPLAY': ':0', 06:29:07 INFO - 'HOME': '/home/cltbld', 06:29:07 INFO - 'LANG': 'en_US.UTF-8', 06:29:07 INFO - 'LANGUAGE': 'en_US:en', 06:29:07 INFO - 'LOGNAME': 'cltbld', 06:29:07 INFO - 'MAIL': '/var/mail/cltbld', 06:29:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:29:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:07 INFO - 'MOZ_NO_REMOTE': '1', 06:29:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:07 INFO - 'NO_EM_RESTART': '1', 06:29:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:07 INFO - 'PWD': '/builds/slave/test', 06:29:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:29:07 INFO - 'SHELL': '/bin/bash', 06:29:07 INFO - 'SHLVL': '1', 06:29:07 INFO - 'TERM': 'linux', 06:29:07 INFO - 'TMOUT': '86400', 06:29:07 INFO - 'USER': 'cltbld', 06:29:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905', 06:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:07 INFO - '_': '/tools/buildbot/bin/python'} 06:29:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 06:29:08 INFO - mozversion application_buildid: 20160617053224 06:29:08 INFO - mozversion application_changeset: 535a13bd2bf94fcc72d7e2432100fba85f7c322a 06:29:08 INFO - mozversion application_display_name: Nightly 06:29:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:29:08 INFO - mozversion application_name: Firefox 06:29:08 INFO - mozversion application_remotingname: firefox 06:29:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:29:08 INFO - mozversion application_vendor: Mozilla 06:29:08 INFO - mozversion application_version: 50.0a1 06:29:08 INFO - mozversion platform_buildid: 20160617053224 06:29:08 INFO - mozversion platform_changeset: 535a13bd2bf94fcc72d7e2432100fba85f7c322a 06:29:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:29:08 INFO - mozversion platform_version: 50.0a1 06:29:08 INFO - using testdate: 1466170148 06:29:08 INFO - actual date: 1466170148 06:29:08 INFO - starting webserver on 'localhost:37336' 06:29:08 INFO - SUITE-START | Running 2 tests 06:29:08 INFO - TEST-START | dromaeo_css 06:29:08 INFO - operating with platform_type : linux_ 06:29:08 INFO - Initialising browser for dromaeo_css test... 06:29:08 INFO - TEST-INFO | started process 30051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVUJVmm/profile http://localhost:37336/getInfo.html) 06:29:13 INFO - PROCESS | 30051 | __metrics Screen width/height:1600/1200 06:29:13 INFO - PROCESS | 30051 | colorDepth:24 06:29:13 INFO - PROCESS | 30051 | Browser inner width/height: 1024/697 06:29:13 INFO - PROCESS | 30051 | __metrics 06:29:14 ERROR - PROCESS | 30051 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 06:29:15 INFO - TEST-INFO | 30051: exit 0 06:29:15 INFO - Browser initialized. 06:29:15 INFO - Running cycle 1/1 for dromaeo_css test... 06:29:15 INFO - TEST-INFO | started process 30169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVUJVmm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:27 INFO - PROCESS | 30169 | RSS: Main: 185774080 06:29:27 INFO - PROCESS | 30169 | 06:30:17 INFO - PROCESS | 30169 | 1466170217104 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] 06:32:29 INFO - PROCESS | 30169 | Cycle 1(1): loaded http://localhost:37336/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37336/tests/dromaeo/cssquery-ext.html) 06:32:30 INFO - PROCESS | 30169 | RSS: Main: 189132800 06:32:30 INFO - PROCESS | 30169 | 06:35:33 INFO - PROCESS | 30169 | Cycle 1(1): loaded http://localhost:37336/tests/dromaeo/cssquery-ext.html (next: http://localhost:37336/tests/dromaeo/cssquery-jquery.html) 06:35:33 INFO - PROCESS | 30169 | RSS: Main: 188497920 06:35:33 INFO - PROCESS | 30169 | 06:38:35 INFO - PROCESS | 30169 | Cycle 1(1): loaded http://localhost:37336/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37336/tests/dromaeo/cssquery-mootools.html) 06:38:36 INFO - PROCESS | 30169 | RSS: Main: 189190144 06:38:36 INFO - PROCESS | 30169 | 06:41:38 INFO - PROCESS | 30169 | Cycle 1(1): loaded http://localhost:37336/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37336/tests/dromaeo/cssquery-prototype.html) 06:41:38 INFO - PROCESS | 30169 | RSS: Main: 186671104 06:41:38 INFO - PROCESS | 30169 | 06:44:41 INFO - PROCESS | 30169 | Cycle 1(1): loaded http://localhost:37336/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37336/tests/dromaeo/cssquery-yui.html) 06:44:42 INFO - PROCESS | 30169 | RSS: Main: 188624896 06:44:42 INFO - PROCESS | 30169 | 06:47:44 INFO - PROCESS | 30169 | Cycle 1(1): loaded http://localhost:37336/tests/dromaeo/cssquery-yui.html (next: http://localhost:37336/tests/dromaeo/cssquery-dojo.html) 06:47:44 INFO - PROCESS | 30169 | RSS: Main: 189427712 06:47:44 INFO - PROCESS | 30169 | 06:47:44 INFO - PROCESS | 30169 | __start_tp_report 06:47:44 INFO - PROCESS | 30169 | _x_x_mozilla_page_load 06:47:44 INFO - PROCESS | 30169 | _x_x_mozilla_page_load_details 06:47:44 INFO - PROCESS | 30169 | |i|pagename|runs| 06:47:44 INFO - PROCESS | 30169 | |0;dojo.html;2625.579907214846;2666.8133230673848;2678.665166854143;2684.892604295827;2694.164808909237;4746.976265118674;4777.116233496806;4784.712917224969;4901.411830580335;4954.578860796837;4695.17834378984;4810.44679861816;4838.9032219355595;4868.488808675092;4891.8777030574165;4424.668149888763;4470.485894122185;4561.794719237642;4570.245909424941;4579.175748365293;548.2194682357086;4364.803583838735;4414.22751018572;4426.601605855472;4484.484284307314;4451.376807246988;4475;4480;4483.417155769762;4518.2319005769095;4484.282514797649;4500.954990450086;4507.842225522091;4513.323001549761;4549.749763762991;4381.123775244963;4414.293713005904;4421.270490369086;4425.867223983286;4436.423264975532;4733.408323959505;4845.515448455161;4854.757262136879;4895.510448955111;4944;5171.741412929338;5188.792448302063;5204.869878253036;5212.635115541913;5265.710385928773;5213.895722085575;5265.131253343194;5275.788968441258;5288;5352.143657014898;4913.606911447076;4914.017196560702;4915.778789954425;4916;4916.8770780730765;5262.342207224097;5357.330333708286;5381.192821076792;5401.837944861661;5408.810691625853;5155.61332900034;5199.896002079937;5207.7916883325;5207.947920520822;5252.29094072303;5291.365036195682;5297.735113244323;5301.655392399559;5306.575473962073;5350.143976963667;5004.974975125101;5103.157978933435;5138.743062846843;5194.0650682876685;5241.606879484054;5157.63896527247;5162.870928226825;5169.043726910533;5190.740462976836;5201.739913004335;4445.777711114431;4453.844115456009;4467.620252278528;4504.707194032443;4513.774311284423;3773.6792372648083;3805.771653700787;3812.7140464465274;3831.578526362098;3870.148567315186;4426.601605855424;4458.086092351125;4476.932846007313;4526.683132180716;4573.862784116482;5264.05247055526;5279.155335146358;5283.445238250005;5295.285136506599;5297.364316282071;4418.359337895987;4466.977665111654;4530.207213737583;4535.31970204472;4551;4714.151452738472;4723.338732577442;4751.429828420612;4753.619710423158;4799.544043315879;4822.927656085231;4947.975260123676;4949.109160351171;4951;5018.924716129261;5109.6678715883345;5141.974290128525;5161.458046905171;5161.896762064663;5188.118019936695;4809.254565542346;4837.661363704507;4844.660873738804;4845.733484658378;4854.878628034327;5042.647014708935;5074.974625126851;5083.415407228068;5134.024535338273;5180.792768289226;5250.501202385767;5289.312389389509;5314.920276195783;5321.733913304397;5369.382521010134;5070.569001634754;5120.334356533627;5130.769115389891;5153.072446959433;5190.636655434083;4934.087193869145;5028.22062580286;5099.260607212008;5125.92311115341;5150.9227361588855;5000.849974500771;5045.646804723781;5064.645474816727;5081.136206844919;5097.388313402415;5217.6086793489885;5217.634765566374;5223.52988231061;5224.6342756008235;5231.529162375405;4918.852434426973;4983.4518202996915;5029.798808047637;5050.191969284897;5089.982003599369 06:47:44 INFO - PROCESS | 30169 | |1;ext.html;542.276888698391;576.8644368573384;581.1109003225066;600.4115966352975;622.315453001698;36704.71533496328;40785.38821917673;40904;40907;41047.384289235684;39979.40030899539;40157.79921100398;40269.59730402695;40285.7985710071;40583.59416405835;7832.490888092284;8035.517868927854;8056.597170141469;8065.475744076645;8065.919340806576;7867.8426431471335;7941.523508589503;7987.400944929124;7999.040115186186;8021.077576078738;7991.600419979007;8023.719169829057;8056.758297251063;8069.39479539034;8070.475419097769;7894.763157105296;7924.722634707787;7942.642581083836;7956.6817327306835;7971.60141992898;7714.537127772352;7821.256980586835;7837.843243135162;7865.68537258509;7875.724349647792;30727.539086913715;39187.21625567473;39578;39637.80181099105;39638;2865.3409715765492;3014.894478693235;3058.2201538607737;3295.0938491914676;3566.4472006838982;28587.85706071477;29083.709162908523;29219.853900730574;29224.70775292241;29265;3392.8473218705217;3395.6604339565847;3424.4642777588056;3448.6378930212218;3479.234568394949;221816;225086;225605;225877;226760.8661956696;33043.3391332172;33368.16579585481;33384.833075834955;33467.16332091717;33486.66513334835;33159.17102072467;34340.48489272663;34345.65654343474;34348;34510.82744586311;14181.936354773434;14190.361433735507;14217.36021879018;14293.070950388192;14316.355763990645;10744.73138171552;10783.13734901206;10783.676489705322;10807.189460790472;10829.566817327377;18374.35689750852;18444.907775461037;18473.353432629792;18481.90759046196;18571.72142417865;6965.33829286217;7000.474964377692;7015.526739384786;7177.497575169792;7216.96391518039;788.7121200761795;887.40100432208;926.8887733472027;934.444005816538;953.2135987810084;28141.296467588065;28860.855695721806;29147.41705165927;29270.7072929268;29514.262143446587;972.4845831709206;974.8537719342014;989.8861630912393;998.8551660009258;1004.3271008424373;14882.925585372004;15357.539273821803;15405.614859628598;15550.922245388927;15558.766618500731;411262;421399;425322;427084;709862;50869.74565127151;51546.74226628918;51726;51853.74073129686;51953;1153.7461758413135;1182.1665725663386;1189.4290740444635;1208.4561947123655;1219.5000049979467;28142.859285703442;29225.269368265963;29680.851595741882;29844;30321;43628.34557481704;44205.55794442014;44231;44316.778416107714;44536.109277813615;280565;281832;282051;282122;282388;25930.870345648153;26236.21291361262;40806.79596601998;42213.1557368857;42277;41798.791006044776;44796.826567529395;45938.32493400453;46005;46468.30297545472;38479.216825517426;38770.0307492315;39468;39637.60362396339;40092;37189.62810371862;37920.241595168496;38620;38936.80531597324;39302;33785;37411;37792.055198620255;38199.6180038196;38415.23169536649;34202.657973420944;35635.643643563235;36050.09874753047;36195.095122622144;36206.45690314595;26762.330941726614;26914.461710766067;27099;27141.86429067842;27634.032808851593 06:47:44 INFO - PROCESS | 30169 | |2;jquery.html;353.75944357836676;362.5287126735244;363.1230578153758;377.0648790998324;379.06560328789527;15757.84242157578;16290.104044277576;17001.2349444275;17067.231974561142;17167.484975450756;15989.360425582992;16168.35326586938;17088.316467341323;17089.316427342892;17136.48590542286;5031.496850314967;5173.094708426029;5196.844094677147;5207.843764687065;5255.369355677324;3719.330520506308;5073.188289873621;5807.0998995155815;6101.0848372744;6104.450599446049;6101.908471372911;6106.908396374058;6135.846603834895;6162.599431036968;6198.75204991802;5076.416212135615;5388.164834450667;5403.2165336026255;5457.399686034533;5465.426130256305;5188.948110518884;5190.896182076337;5276.5251127398715;5332.786688532493;5334.5732341412595;18254.726179107325;19588.314408995615;19606.80393196064;19819.207231710858;20120.09459574308;1849.713294439364;2081.8646787958733;2184.1809321504434;2212.6791615215866;2400.8439451435775;8498.235158835734;8704.347173961978;8879.556022198864;9007.324450666161;9129.406588571721;1600.3518574977154;1667.374734474572;1724.7378100303122;1725.3098760495777;1758.8364620328107;40755.59244407577;41141.38287925684;41669;68079.31920680829;69398;9716.785401824773;9861.802763944681;10094.545745441474;10182.23633227511;10214;13851.722965540634;13965.930170349084;14003.71992560143;14023.719525609431;14059.156450612996;6695.933040669628;6747.460203183734;6840.965795170992;6881.793546193622;6911.481638877104;6212.223472065992;6298.559100862987;6397.840053998687;6407.295197528269;6409.487241020707;4191.266528357586;4209.705320627527;4213.789310534461;4365.345198220292;4487.237169681162;1556.820965588949;1702.2425020865844;1754.526277904984;1778.7065134252703;1816.4369045595909;785.5286827903212;846.9618867150994;867.1588559097665;871.172386233081;934;16606.50180494587;16618.83381166197;16737.748933766004;16931.407400740914;16994.490165294814;840.4159109419018;841.3857883744901;852.7868032991752;859.6002858670748;884.8009197930543;9501.714948551555;9510.191633711212;9541.332106752461;9586.281028922858;9741.707748767549;391861;403665;410788;414237;416386;72854.63572682103;76332.61833690907;77587;78722.6063869677;80351.59824200842;883.5847151838625;885.0706757904175;892.5804871710286;896.0636135238691;897.0894542039835;14828.258587070388;15044.849551504783;15116.244187790346;15272.312745926682;15305.392933742241;36624.45063324105;36988.44517332188;37084;37102.25795484129;38528.42207366836;45950.08099837918;49731;51101.488985109674;51163;51386.48613513817;6958.338957799001;7086.362227399352;7097.183823860116;7253.347198752138;7576.772696819105;10836;11756.353400563052;11851.52593896269;11942.283462992249;12255.75488490243;10227.84658230142;10375;10508;10660;10716.571337146426;10285.125764310118;10348.534315955649;10548.103411210133;10611.575536978435;10627.309224900357;10323.690289291333;10576.576936922436;10674.946625267135;10722.463876806285;10748;7362.190159082389;7431.739889104072;7480.251974802693;7584.5070070445245;7711.0746710395115;9996;10120.898791011996;10209.846852297072;10343.37939723619;10555.52500137511 06:47:44 INFO - PROCESS | 30169 | |3;mootools.html;1345.192884269438;1374.656335916021;1466.985330146699;1674.7152983992721;1681.302259562281;7191.244919283478;7668.079830420351;7757.22427757224;8211.096779354266;8226.465279756812;7764.340031097349;8010.5594192319395;8054.073781515128;8064.395170362217;8066.757997260077;2213.7896899794573;2255.23322070496;2255.5939930812447;2257.8306627002958;2261.6381378979368;2228.4317499037725;2239.496113374486;2298.37943755186;2298.8965496552696;2309.84985975911;2240.7199100112484;2243.2260869999823;2246.0117548278786;2254.718160229971;2255.6954811100536;2140.668196429556;2153.364757396556;2155.665871789867;2162.0486985726307;2170.533335332911;2124.192806733447;2126.1070350452846;2143.710599069137;2146.1844499090403;2153.3001774423374;7955.323797477221;8067.112617612058;8104.959475202645;8125.837483250361;8126.593670316461;4461.732296062247;4535.183666939949;4595.540445955377;4624.190766615829;4626.21354369758;2766.6443442713125;2814.7888908331956;2911;2917.7957542972;2937.3097322129283;870.1863757386864;891.0910870911698;891.3092353426147;913.5980168725806;923.5382308845577;10490.685279441628;10686.358818470917;10727.83908241377;10778.514966826433;10790.73023174419;4127.174565086994;4222.366645003212;4302.247106756305;4311.698181127291;4316.482022157361;8921.420107692978;8973.28213742899;9201.90798092024;9225.953870230605;9250.306227033;4546.704464209815;4568.200564901129;4580.97709511457;4582.08358328329;4610.9308360374625;3623.130448692295;4110.671146308348;4122.051928056564;4174.91650166995;4305.655547556188;3641.708663306929;3702.7593206441493;3752.3996160614715;3784.735068545175;3798.6961043116485;1179.628417048627;1198.358878000283;1200.5317926008863;1210.8244304575787;1220.4690959432498;722.6170129831198;812.7846120777998;814.539785021461;834.8163404051099;836.7908022994252;5065.265536497187;5251.789928402897;5262.052830490472;5282.154855223146;5285;368.8874893157559;383.26987089594365;388.50077650219333;400.3014739279975;403.8303912356817;3511.94732079019;3524.788512689247;3554.3424466473266;3558.4128618777613;3586.497890295361;9369.906300936904;9638.325317227867;9750.853737193947;9758;9782.11960923506;9527.47598882068;9569.856452153223;9639.228861691048;9733.853992190123;9736.610535578639;7389.926100739031;7415.443841711894;7446.069241344832;7475.6262186890435;7508.0990281166605;4983.775730092082;5110.872228194325;5186.585073194211;5241.449647786927;5254.7898084076205;9066.365354425126;9069.77325566866;9101.135392137736;9128.087191280818;9136.725898223063;8953.731388058368;9145.131212534798;9184.954075229849;9343.906560934576;9368.156865882103;6065.514758819372;6622.602643841385;6755.121834161528;6867.690953906987;6901.344372284625;7193.604351760703;7281.745138920112;7288.052553168054;7361.779146625609;7383.372413344926;6494.188226471691;6653.933460665331;6703.731850725916;6727.73089076451;6817.454603631599;6491.253505846888;6527.934720652923;6580.605163690194;6651.800445986628;6729.730810767514;5949.7620095197435;5954.821355359346;6046.879062418639;6058.727357269022;6060.151578778887;4449.822007119679;4522.773861306987;4551.431071116111;4558.179527685049;4614.423197100363;4402.691811573287;4514.210013247734;4580.427446569179;4592.402987611723;4600.056988317454 06:47:44 INFO - PROCESS | 30169 | |4;prototype.html;285.86796286704646;286.805455278764;291.7826219466498;297.784106522771;303.17687478495884;5106.668066575679;5120.615953803465;5125.333706618139;5126.2570725953165;5149.524071251899;5088.5143676581565;5089.77845317124;5092.134337162682;5092.490750924906;5125.436202017775;3775.6413140751583;3857.8071096445206;3944.9408258876138;3954.228925359556;3962.6829853611644;3940;3950.3876899080688;3980.1044764927806;3985.6811455083525;3999.1401848602545;3946.796227150718;3964.742291751027;3977.2443235785254;3977.423273625337;3977.86077487288;3731.067233191702;3917.275304068728;3936.4488971544006;3986.740861843971;3989.700772442064;3446.3968805458944;3449.1721986723255;3466.3067386522544;3476.5132881396626;3494.982525087358;4917;4921.950780492185;4987.825426110068;4990.451050384455;5012.147934851084;4426.710081452666;4553.954460455386;4564.908701825978;4577.9542204577865;4596.3794887690065;5255.710935898524;5326.760295786699;5337.6797392156595;5344.625876188668;5361.544268737162;3817.1602247505502;3849.9807500962597;3855.749376290532;3861.2470568239205;3869.941950870711;5485.917711234335;5605.523530499912;5631.802886898939;5651.519620832234;5677.148427735831;3880.825362858678;3889.747166434173;3904.141088960424;3907.941380879289;3911.3155197840265;3930.194310166409;3957.3272543667645;3962.841486340514;3968.6825053995613;3978.224246271949;4492.303692927601;4539.841105561355;4544.7500387479;4547.931781023221;4600.7469589172915;5145.276332428603;5310.628256022042;5313.1764576490705;5319.1223448131395;5344.278522399504;1356.8982326325565;1369.6986662934337;1370.5545697648304;1373.9725205495834;1374.5807528703842;849.755108765649;868.1145231863591;896.6682327538853;902.0753727429307;909.4725059465494;4493.955060449353;4584.404027476407;4612.423447069116;4676.625869930397;4688.109259240733;5542.334919809648;5596.888062238732;5601.551875849922;5627.662340259598;5629;4472.888177795581;4695.3191787191345;4706.529347065266;4732.503087175865;4733.384659994247;2954.3057381515328;2994.460997020514;3000.159955212544;3003.2041509000132;3008.819470831757;5173.275741396207;5193.844184674465;5206.245094461282;5213.556847667991;5241.73791310433;5386.91919621206;5671.489565939085;5678.432156784371;5681.57388195887;5700.4299570043495;5207.9999999999245;5209;5219.556337711337;5232.947670523322;5245.763940622757;5584.692841893735;5594.552435805044;5594.776208951596;5613.298337707786;5617.466340697627;5275.314209152785;5475.72621368938;5492.148716948879;5496.148097044965;5524.4199359066715;5178.61160412963;5246.632735708464;5249.475052494873;5249.873801110556;5275.393329767126;3816.7137464689704;3826.3303921814127;3835.980820095882;3847.2305538892892;3853.8265778039495;5379.73101344939;5552.472515111058;5552.472515111058;5569.498745112959;5570.108782594765;5379.4082650907585;5384.219288203267;5389.8113566025;5435.565154787687;5438.537724293479;5219;5300.946990530199;5312.468753124656;5313.495217954288;5389.865253368697;5254.159334506614;5278.81524146653;5288.233206185005;5296.682199068068;5301.416844147064;5195.896082078413;5311.256424100707;5455.563554915518;5459.836204913859;5464.644798088111;5294.814681486284;5312.574994000393;5315.495027972336;5324.600654950972;5325.147976323769 06:47:44 INFO - PROCESS | 30169 | |5;yui.html;647.870425914817;685.9607694343072;690.454540912679;707.5012116457898;731.5903094267208;12607.180533265342;13833.239171845556;13838.861611383883;14278.428862845474;14288.142711437322;14605.707885842277;14692.853071469282;14696.191709456003;14776.335064922077;14793.334299956501;621.4624349937294;762.3824701991405;789.6130895861015;797.11520212564;802.1657476224719;795.8169620987177;796.8605494038549;797.6131576185575;798.4490701416033;801.5751651624648;820.327331588098;822.3256929317962;826.1284345016036;829.60179114025;830.8421399934024;816.2735165702529;821.2157389692859;823.5141266652673;823.6869989404048;824.2787560884167;603.7253049862302;606.7663949379477;608.1000119822643;608.5496732418023;609.0285993839818;13802.585922422344;13802.930985345009;13830.308484575731;13832.30838458083;13843.723125537434;13041.478340866353;13229.55643368489;13354.465821367134;13429.932850335686;13469.393877275448;10345.534450949724;10436.84344734822;10480.371177729285;10528.105111065568;10627.734306642396;3322.60128784545;3360.8319584020946;3369.528266042756;3375.4093033719;3431.5024321473497;44575.77712111451;44746;50570.49429505732;56250.43749562493;56816;10206.948965255275;10273.229507786946;10345.496411750903;10359.94820025895;10422.322549034288;18706.438806835817;18759.0620468976;18767.436976890716;18853.52866178329;18862.24551017944;6589.800620380803;6647.933520664828;6724.740058734832;6746.055552222692;6803.829904252433;3615.204654975901;3631.5655316149973;3639.6906262967414;3668.9816550917076;3694.07648087978;2922.7369536741794;2980.5231163013814;3003.3692924486104;3014.2464383904025;3039.300960779033;497.7536119620811;502.87428142964256;504.4703061785111;506.2937202602349;517.585931255002;357.174925921123;405.3473907009712;471.7641179410295;483.8887055977075;498.80546586831167;7505.737299194502;7686.346660533805;7756.263155000266;7804.570748608768;7820.608969551499;406.2991339938582;458.46817691477725;468.50338641040605;471.90797794429756;487.87788087398843;3740.532433445819;3787.110029143149;3807.9428808567895;3858.5176852893387;4038.495188101487;91131.54434227786;94353.52823235978;94753.5262323684;95031.52484237535;96666.51666741761;48349.274760878616;48585.27122093172;66383.33616663868;68579.65710171417;69562.3043769566;70104.2989570108;70111.64944175247;70138.2986170142;70626;72969;8726;8786.868196977179;9050.683226087056;9094.317926155698;9105.408148470327;41942.58057419509;42169.94575135646;42276;43373.78313108414;44233.557664422944;56518.434815651315;57183;61150.69424652848;64300;64828.675856620415;10968.17738669587;11057.11543076568;11141.777164456827;11153.330800152016;11306.4912078955;12589.496420143458;12898.935505322788;12995.155314904501;13129.146605470614;13132.868671313547;11558.537658493902;11806.232594881305;11872.347020913932;12147.81778273309;12449.696806090902;11619;11927.522899084286;12219.205751626116;12276.938615306866;12524.06069544806;9796.363236389612;11098.389588572705;11216.66350009501;11379.658610241706;12356.443960022001;9645.37305075196;10642.255042146975;10754.354738715701;10964.232503724663;11168.553257869595;10038.297319187586;10198.808047917213;10420.114290285108;10727.570897164025;10776.568937242737 06:47:44 INFO - PROCESS | 30169 | __end_tp_report 06:47:44 INFO - PROCESS | 30169 | __start_cc_report 06:47:44 INFO - PROCESS | 30169 | _x_x_mozilla_cycle_collect,395 06:47:44 INFO - PROCESS | 30169 | __end_cc_report 06:47:44 INFO - PROCESS | 30169 | __startTimestamp1466171264620__endTimestamp 06:47:44 INFO - PROCESS | 30169 | 06:47:44 INFO - PROCESS | 30169 | ------- Summary: start ------- 06:47:44 INFO - PROCESS | 30169 | Number of tests: 6 06:47:44 INFO - PROCESS | 30169 | 06:47:44 INFO - PROCESS | 30169 | [#0] dojo.html Cycles:165 Average:4803.25 Median:4949.11 stddev:620.03 (12.5%) stddev-sans-first:597.93 06:47:44 INFO - PROCESS | 30169 | Values: 2625.6 2666.8 2678.7 2684.9 2694.2 4747.0 4777.1 4784.7 4901.4 4954.6 4695.2 4810.4 4838.9 4868.5 4891.9 4424.7 4470.5 4561.8 4570.2 4579.2 548.2 4364.8 4414.2 4426.6 4484.5 4451.4 4475.0 4480.0 4483.4 4518.2 4484.3 4501.0 4507.8 4513.3 4549.7 4381.1 4414.3 4421.3 4425.9 4436.4 4733.4 4845.5 4854.8 4895.5 4944.0 5171.7 5188.8 5204.9 5212.6 5265.7 5213.9 5265.1 5275.8 5288.0 5352.1 4913.6 4914.0 4915.8 4916.0 4916.9 5262.3 5357.3 5381.2 5401.8 5408.8 5155.6 5199.9 5207.8 5207.9 5252.3 5291.4 5297.7 5301.7 5306.6 5350.1 5005.0 5103.2 5138.7 5194.1 5241.6 5157.6 5162.9 5169.0 5190.7 5201.7 4445.8 4453.8 4467.6 4504.7 4513.8 3773.7 3805.8 3812.7 3831.6 3870.1 4426.6 4458.1 4476.9 4526.7 4573.9 5264.1 5279.2 5283.4 5295.3 5297.4 4418.4 4467.0 4530.2 4535.3 4551.0 4714.2 4723.3 4751.4 4753.6 4799.5 4822.9 4948.0 4949.1 4951.0 5018.9 5109.7 5142.0 5161.5 5161.9 5188.1 4809.3 4837.7 4844.7 4845.7 4854.9 5042.6 5075.0 5083.4 5134.0 5180.8 5250.5 5289.3 5314.9 5321.7 5369.4 5070.6 5120.3 5130.8 5153.1 5190.6 4934.1 5028.2 5099.3 5125.9 5150.9 5000.8 5045.6 5064.6 5081.1 5097.4 5217.6 5217.6 5223.5 5224.6 5231.5 4918.9 4983.5 5029.8 5050.2 5090.0 06:47:44 INFO - PROCESS | 30169 | 06:47:44 INFO - PROCESS | 30169 | [#1] ext.html Cycles:180 Average:48018.73 Median:38307.42 stddev:93798.81 (244.9%) stddev-sans-first:93994.21 06:47:44 INFO - PROCESS | 30169 | Values: 542.3 576.9 581.1 600.4 622.3 36704.7 40785.4 40904.0 40907.0 41047.4 39979.4 40157.8 40269.6 40285.8 40583.6 7832.5 8035.5 8056.6 8065.5 8065.9 7867.8 7941.5 7987.4 7999.0 8021.1 7991.6 8023.7 8056.8 8069.4 8070.5 7894.8 7924.7 7942.6 7956.7 7971.6 7714.5 7821.3 7837.8 7865.7 7875.7 30727.5 39187.2 39578.0 39637.8 39638.0 2865.3 3014.9 3058.2 3295.1 3566.4 28587.9 29083.7 29219.9 29224.7 29265.0 3392.8 3395.7 3424.5 3448.6 3479.2 221816.0 225086.0 225605.0 225877.0 226760.9 33043.3 33368.2 33384.8 33467.2 33486.7 33159.2 34340.5 34345.7 34348.0 34510.8 14181.9 14190.4 14217.4 14293.1 14316.4 10744.7 10783.1 10783.7 10807.2 10829.6 18374.4 18444.9 18473.4 18481.9 18571.7 6965.3 7000.5 7015.5 7177.5 7217.0 788.7 887.4 926.9 934.4 953.2 28141.3 28860.9 29147.4 29270.7 29514.3 972.5 974.9 989.9 998.9 1004.3 14882.9 15357.5 15405.6 15550.9 15558.8 411262.0 421399.0 425322.0 427084.0 709862.0 50869.7 51546.7 51726.0 51853.7 51953.0 1153.7 1182.2 1189.4 1208.5 1219.5 28142.9 29225.3 29680.9 29844.0 30321.0 43628.3 44205.6 44231.0 44316.8 44536.1 280565.0 281832.0 282051.0 282122.0 282388.0 25930.9 26236.2 40806.8 42213.2 42277.0 41798.8 44796.8 45938.3 46005.0 46468.3 38479.2 38770.0 39468.0 39637.6 40092.0 37189.6 37920.2 38620.0 38936.8 39302.0 33785.0 37411.0 37792.1 38199.6 38415.2 34202.7 35635.6 36050.1 36195.1 36206.5 26762.3 26914.5 27099.0 27141.9 27634.0 06:47:44 INFO - PROCESS | 30169 | 06:47:44 INFO - PROCESS | 30169 | [#2] jquery.html Cycles:180 Average:24238.75 Median:22930.13 stddev:66958.47 (292.0%) stddev-sans-first:67122.29 06:47:44 INFO - PROCESS | 30169 | Values: 353.8 362.5 363.1 377.1 379.1 15757.8 16290.1 17001.2 17067.2 17167.5 15989.4 16168.4 17088.3 17089.3 17136.5 5031.5 5173.1 5196.8 5207.8 5255.4 3719.3 5073.2 5807.1 6101.1 6104.5 6101.9 6106.9 6135.8 6162.6 6198.8 5076.4 5388.2 5403.2 5457.4 5465.4 5188.9 5190.9 5276.5 5332.8 5334.6 18254.7 19588.3 19606.8 19819.2 20120.1 1849.7 2081.9 2184.2 2212.7 2400.8 8498.2 8704.3 8879.6 9007.3 9129.4 1600.4 1667.4 1724.7 1725.3 1758.8 40755.6 41141.4 41669.0 68079.3 69398.0 9716.8 9861.8 10094.5 10182.2 10214.0 13851.7 13965.9 14003.7 14023.7 14059.2 6695.9 6747.5 6841.0 6881.8 6911.5 6212.2 6298.6 6397.8 6407.3 6409.5 4191.3 4209.7 4213.8 4365.3 4487.2 1556.8 1702.2 1754.5 1778.7 1816.4 785.5 847.0 867.2 871.2 934.0 16606.5 16618.8 16737.7 16931.4 16994.5 840.4 841.4 852.8 859.6 884.8 9501.7 9510.2 9541.3 9586.3 9741.7 391861.0 403665.0 410788.0 414237.0 416386.0 72854.6 76332.6 77587.0 78722.6 80351.6 883.6 885.1 892.6 896.1 897.1 14828.3 15044.8 15116.2 15272.3 15305.4 36624.5 36988.4 37084.0 37102.3 38528.4 45950.1 49731.0 51101.5 51163.0 51386.5 6958.3 7086.4 7097.2 7253.3 7576.8 10836.0 11756.4 11851.5 11942.3 12255.8 10227.8 10375.0 10508.0 10660.0 10716.6 10285.1 10348.5 10548.1 10611.6 10627.3 10323.7 10576.6 10674.9 10722.5 10748.0 7362.2 7431.7 7480.3 7584.5 7711.1 9996.0 10120.9 10209.8 10343.4 10555.5 06:47:44 INFO - PROCESS | 30169 | 06:47:44 INFO - PROCESS | 30169 | [#3] mootools.html Cycles:180 Average:5136.76 Median:5024.52 stddev:2920.09 (58.1%) stddev-sans-first:2914.38 06:47:44 INFO - PROCESS | 30169 | Values: 1345.2 1374.7 1467.0 1674.7 1681.3 7191.2 7668.1 7757.2 8211.1 8226.5 7764.3 8010.6 8054.1 8064.4 8066.8 2213.8 2255.2 2255.6 2257.8 2261.6 2228.4 2239.5 2298.4 2298.9 2309.8 2240.7 2243.2 2246.0 2254.7 2255.7 2140.7 2153.4 2155.7 2162.0 2170.5 2124.2 2126.1 2143.7 2146.2 2153.3 7955.3 8067.1 8105.0 8125.8 8126.6 4461.7 4535.2 4595.5 4624.2 4626.2 2766.6 2814.8 2911.0 2917.8 2937.3 870.2 891.1 891.3 913.6 923.5 10490.7 10686.4 10727.8 10778.5 10790.7 4127.2 4222.4 4302.2 4311.7 4316.5 8921.4 8973.3 9201.9 9226.0 9250.3 4546.7 4568.2 4581.0 4582.1 4610.9 3623.1 4110.7 4122.1 4174.9 4305.7 3641.7 3702.8 3752.4 3784.7 3798.7 1179.6 1198.4 1200.5 1210.8 1220.5 722.6 812.8 814.5 834.8 836.8 5065.3 5251.8 5262.1 5282.2 5285.0 368.9 383.3 388.5 400.3 403.8 3511.9 3524.8 3554.3 3558.4 3586.5 9369.9 9638.3 9750.9 9758.0 9782.1 9527.5 9569.9 9639.2 9733.9 9736.6 7389.9 7415.4 7446.1 7475.6 7508.1 4983.8 5110.9 5186.6 5241.4 5254.8 9066.4 9069.8 9101.1 9128.1 9136.7 8953.7 9145.1 9185.0 9343.9 9368.2 6065.5 6622.6 6755.1 6867.7 6901.3 7193.6 7281.7 7288.1 7361.8 7383.4 6494.2 6653.9 6703.7 6727.7 6817.5 6491.3 6527.9 6580.6 6651.8 6729.7 5949.8 5954.8 6046.9 6058.7 6060.2 4449.8 4522.8 4551.4 4558.2 4614.4 4402.7 4514.2 4580.4 4592.4 4600.1 06:47:44 INFO - PROCESS | 30169 | 06:47:44 INFO - PROCESS | 30169 | [#4] prototype.html Cycles:180 Average:4451.15 Median:5122.97 stddev:1305.07 (25.5%) stddev-sans-first:1270.73 06:47:44 INFO - PROCESS | 30169 | Values: 285.9 286.8 291.8 297.8 303.2 5106.7 5120.6 5125.3 5126.3 5149.5 5088.5 5089.8 5092.1 5092.5 5125.4 3775.6 3857.8 3944.9 3954.2 3962.7 3940.0 3950.4 3980.1 3985.7 3999.1 3946.8 3964.7 3977.2 3977.4 3977.9 3731.1 3917.3 3936.4 3986.7 3989.7 3446.4 3449.2 3466.3 3476.5 3495.0 4917.0 4922.0 4987.8 4990.5 5012.1 4426.7 4554.0 4564.9 4578.0 4596.4 5255.7 5326.8 5337.7 5344.6 5361.5 3817.2 3850.0 3855.7 3861.2 3869.9 5485.9 5605.5 5631.8 5651.5 5677.1 3880.8 3889.7 3904.1 3907.9 3911.3 3930.2 3957.3 3962.8 3968.7 3978.2 4492.3 4539.8 4544.8 4547.9 4600.7 5145.3 5310.6 5313.2 5319.1 5344.3 1356.9 1369.7 1370.6 1374.0 1374.6 849.8 868.1 896.7 902.1 909.5 4494.0 4584.4 4612.4 4676.6 4688.1 5542.3 5596.9 5601.6 5627.7 5629.0 4472.9 4695.3 4706.5 4732.5 4733.4 2954.3 2994.5 3000.2 3003.2 3008.8 5173.3 5193.8 5206.2 5213.6 5241.7 5386.9 5671.5 5678.4 5681.6 5700.4 5208.0 5209.0 5219.6 5232.9 5245.8 5584.7 5594.6 5594.8 5613.3 5617.5 5275.3 5475.7 5492.1 5496.1 5524.4 5178.6 5246.6 5249.5 5249.9 5275.4 3816.7 3826.3 3836.0 3847.2 3853.8 5379.7 5552.5 5552.5 5569.5 5570.1 5379.4 5384.2 5389.8 5435.6 5438.5 5219.0 5300.9 5312.5 5313.5 5389.9 5254.2 5278.8 5288.2 5296.7 5301.4 5195.9 5311.3 5455.6 5459.8 5464.6 5294.8 5312.6 5315.5 5324.6 5325.1 06:47:44 INFO - PROCESS | 30169 | 06:47:44 INFO - PROCESS | 30169 | [#5] yui.html Cycles:180 Average:16621.96 Median:21174.44 stddev:22637.97 (106.9%) stddev-sans-first:22669.70 06:47:44 INFO - PROCESS | 30169 | Values: 647.9 686.0 690.5 707.5 731.6 12607.2 13833.2 13838.9 14278.4 14288.1 14605.7 14692.9 14696.2 14776.3 14793.3 621.5 762.4 789.6 797.1 802.2 795.8 796.9 797.6 798.4 801.6 820.3 822.3 826.1 829.6 830.8 816.3 821.2 823.5 823.7 824.3 603.7 606.8 608.1 608.5 609.0 13802.6 13802.9 13830.3 13832.3 13843.7 13041.5 13229.6 13354.5 13429.9 13469.4 10345.5 10436.8 10480.4 10528.1 10627.7 3322.6 3360.8 3369.5 3375.4 3431.5 44575.8 44746.0 50570.5 56250.4 56816.0 10206.9 10273.2 10345.5 10359.9 10422.3 18706.4 18759.1 18767.4 18853.5 18862.2 6589.8 6647.9 6724.7 6746.1 6803.8 3615.2 3631.6 3639.7 3669.0 3694.1 2922.7 2980.5 3003.4 3014.2 3039.3 497.8 502.9 504.5 506.3 517.6 357.2 405.3 471.8 483.9 498.8 7505.7 7686.3 7756.3 7804.6 7820.6 406.3 458.5 468.5 471.9 487.9 3740.5 3787.1 3807.9 3858.5 4038.5 91131.5 94353.5 94753.5 95031.5 96666.5 48349.3 48585.3 66383.3 68579.7 69562.3 70104.3 70111.6 70138.3 70626.0 72969.0 8726.0 8786.9 9050.7 9094.3 9105.4 41942.6 42169.9 42276.0 43373.8 44233.6 56518.4 57183.0 61150.7 64300.0 64828.7 10968.2 11057.1 11141.8 11153.3 11306.5 12589.5 12898.9 12995.2 13129.1 13132.9 11558.5 11806.2 11872.3 12147.8 12449.7 11619.0 11927.5 12219.2 12276.9 12524.1 9796.4 11098.4 11216.7 11379.7 12356.4 9645.4 10642.3 10754.4 10964.2 11168.6 10038.3 10198.8 10420.1 10727.6 10776.6 06:47:44 INFO - PROCESS | 30169 | -------- Summary: end -------- 06:47:44 INFO - PROCESS | 30169 | 06:47:45 INFO - TEST-INFO | 30169: exit 0 06:47:45 INFO - TEST-OK | dromaeo_css | took 1117287ms 06:47:45 INFO - TEST-START | kraken 06:47:45 INFO - operating with platform_type : linux_ 06:47:45 INFO - Initialising browser for kraken test... 06:47:45 INFO - TEST-INFO | started process 30418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJwzMhb/profile http://localhost:37336/getInfo.html) 06:47:50 INFO - PROCESS | 30418 | __metrics Screen width/height:1600/1200 06:47:50 INFO - PROCESS | 30418 | colorDepth:24 06:47:50 INFO - PROCESS | 30418 | Browser inner width/height: 1024/697 06:47:50 INFO - PROCESS | 30418 | __metrics 06:47:51 ERROR - PROCESS | 30418 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 06:47:52 INFO - TEST-INFO | 30418: exit 0 06:47:52 INFO - Browser initialized. 06:47:52 INFO - Running cycle 1/1 for kraken test... 06:47:52 INFO - TEST-INFO | started process 30536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJwzMhb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:48:04 INFO - PROCESS | 30536 | RSS: Main: 186667008 06:48:04 INFO - PROCESS | 30536 | 06:48:07 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37336/tests/kraken/driver.html?testName=audio-beat-detection) 06:48:08 INFO - PROCESS | 30536 | RSS: Main: 191692800 06:48:08 INFO - PROCESS | 30536 | 06:48:10 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37336/tests/kraken/driver.html?testName=audio-dft) 06:48:11 INFO - PROCESS | 30536 | RSS: Main: 190812160 06:48:11 INFO - PROCESS | 30536 | 06:48:14 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37336/tests/kraken/driver.html?testName=audio-fft) 06:48:15 INFO - PROCESS | 30536 | RSS: Main: 186187776 06:48:15 INFO - PROCESS | 30536 | 06:48:17 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37336/tests/kraken/driver.html?testName=audio-oscillator) 06:48:18 INFO - PROCESS | 30536 | RSS: Main: 187215872 06:48:18 INFO - PROCESS | 30536 | 06:48:20 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37336/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:48:20 INFO - PROCESS | 30536 | RSS: Main: 187097088 06:48:20 INFO - PROCESS | 30536 | 06:48:24 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37336/tests/kraken/driver.html?testName=imaging-darkroom) 06:48:24 INFO - PROCESS | 30536 | RSS: Main: 187375616 06:48:24 INFO - PROCESS | 30536 | 06:48:28 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37336/tests/kraken/driver.html?testName=imaging-desaturate) 06:48:28 INFO - PROCESS | 30536 | RSS: Main: 185225216 06:48:28 INFO - PROCESS | 30536 | 06:48:31 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37336/tests/kraken/driver.html?testName=json-parse-financial) 06:48:32 INFO - PROCESS | 30536 | RSS: Main: 186023936 06:48:32 INFO - PROCESS | 30536 | 06:48:34 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37336/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:48:34 INFO - PROCESS | 30536 | RSS: Main: 187555840 06:48:34 INFO - PROCESS | 30536 | 06:48:36 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37336/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:48:37 INFO - PROCESS | 30536 | RSS: Main: 186322944 06:48:37 INFO - PROCESS | 30536 | 06:48:39 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37336/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:48:40 INFO - PROCESS | 30536 | RSS: Main: 186781696 06:48:40 INFO - PROCESS | 30536 | 06:48:43 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:48:43 INFO - PROCESS | 30536 | RSS: Main: 187138048 06:48:43 INFO - PROCESS | 30536 | 06:48:46 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:48:47 INFO - PROCESS | 30536 | RSS: Main: 186806272 06:48:47 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | Cycle 1(1): loaded http://localhost:37336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37336/tests/kraken/driver.html?testName=ai-astar) 06:48:49 INFO - PROCESS | 30536 | RSS: Main: 188059648 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | __start_tp_report 06:48:49 INFO - PROCESS | 30536 | _x_x_mozilla_page_load 06:48:49 INFO - PROCESS | 30536 | _x_x_mozilla_page_load_details 06:48:49 INFO - PROCESS | 30536 | |i|pagename|runs| 06:48:49 INFO - PROCESS | 30536 | |0;ai-astar;115;108;115;113;114;114;113;113;115;115 06:48:49 INFO - PROCESS | 30536 | |1;audio-beat-detection;159;132;156;191;133;158;163;134;204;139 06:48:49 INFO - PROCESS | 30536 | |2;audio-dft;163;171;169;163;161;165;163;165;162;161 06:48:49 INFO - PROCESS | 30536 | |3;audio-fft;77;76;75;174;78;76;87;76;159;78 06:48:49 INFO - PROCESS | 30536 | |4;audio-oscillator;86;86;148;87;87;87;129;86;86;142 06:48:49 INFO - PROCESS | 30536 | |5;imaging-gaussian-blur;118;117;117;119;117;118;118;117;117;118 06:48:49 INFO - PROCESS | 30536 | |6;imaging-darkroom;152;150;148;149;148;150;148;148;147;149 06:48:49 INFO - PROCESS | 30536 | |7;imaging-desaturate;95;96;96;95;96;96;95;96;95;95 06:48:49 INFO - PROCESS | 30536 | |8;json-parse-financial;64;62;64;63;64;64;63;68;64;63 06:48:49 INFO - PROCESS | 30536 | |9;json-stringify-tinderbox;64;65;64;66;65;65;65;66;65;65 06:48:49 INFO - PROCESS | 30536 | |10;stanford-crypto-aes;87;83;87;87;86;92;86;86;113;85 06:48:49 INFO - PROCESS | 30536 | |11;stanford-crypto-ccm;137;133;143;133;142;136;146;134;139;133 06:48:49 INFO - PROCESS | 30536 | |12;stanford-crypto-pbkdf2;172;173;172;169;172;175;176;172;174;173 06:48:49 INFO - PROCESS | 30536 | |13;stanford-crypto-sha256-iterative;71;71;70;71;69;68;68;76;67;70 06:48:49 INFO - PROCESS | 30536 | __end_tp_report 06:48:49 INFO - PROCESS | 30536 | __start_cc_report 06:48:49 INFO - PROCESS | 30536 | _x_x_mozilla_cycle_collect,998 06:48:49 INFO - PROCESS | 30536 | __end_cc_report 06:48:49 INFO - PROCESS | 30536 | __startTimestamp1466171329300__endTimestamp 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | ------- Summary: start ------- 06:48:49 INFO - PROCESS | 30536 | Number of tests: 14 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:2.12 (1.9%) stddev-sans-first:2.18 06:48:49 INFO - PROCESS | 30536 | Values: 115.0 108.0 115.0 113.0 114.0 114.0 113.0 113.0 115.0 115.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#1] audio-beat-detection Cycles:10 Average:156.90 Median:158.50 stddev:24.63 (15.5%) stddev-sans-first:26.12 06:48:49 INFO - PROCESS | 30536 | Values: 159.0 132.0 156.0 191.0 133.0 158.0 163.0 134.0 204.0 139.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:3.33 (2.0%) stddev-sans-first:3.50 06:48:49 INFO - PROCESS | 30536 | Values: 163.0 171.0 169.0 163.0 161.0 165.0 163.0 165.0 162.0 161.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.50 stddev:37.69 (49.3%) stddev-sans-first:39.37 06:48:49 INFO - PROCESS | 30536 | Values: 77.0 76.0 75.0 174.0 78.0 76.0 87.0 76.0 159.0 78.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:86.00 stddev:26.12 (30.4%) stddev-sans-first:27.03 06:48:49 INFO - PROCESS | 30536 | Values: 86.0 86.0 148.0 87.0 87.0 87.0 129.0 86.0 86.0 142.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 06:48:49 INFO - PROCESS | 30536 | Values: 118.0 117.0 117.0 119.0 117.0 118.0 118.0 117.0 117.0 118.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.45 (1.0%) stddev-sans-first:1.01 06:48:49 INFO - PROCESS | 30536 | Values: 152.0 150.0 148.0 149.0 148.0 150.0 148.0 148.0 147.0 149.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:48:49 INFO - PROCESS | 30536 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:1.60 (2.5%) stddev-sans-first:1.69 06:48:49 INFO - PROCESS | 30536 | Values: 64.0 62.0 64.0 63.0 64.0 64.0 63.0 68.0 64.0 63.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 06:48:49 INFO - PROCESS | 30536 | Values: 64.0 65.0 64.0 66.0 65.0 65.0 65.0 66.0 65.0 65.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:86.50 stddev:8.66 (10.0%) stddev-sans-first:9.15 06:48:49 INFO - PROCESS | 30536 | Values: 87.0 83.0 87.0 87.0 86.0 92.0 86.0 86.0 113.0 85.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:138.00 stddev:4.72 (3.4%) stddev-sans-first:5.00 06:48:49 INFO - PROCESS | 30536 | Values: 137.0 133.0 143.0 133.0 142.0 136.0 146.0 134.0 139.0 133.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:1.93 (1.1%) stddev-sans-first:2.03 06:48:49 INFO - PROCESS | 30536 | Values: 172.0 173.0 172.0 169.0 172.0 175.0 176.0 172.0 174.0 173.0 06:48:49 INFO - PROCESS | 30536 | 06:48:49 INFO - PROCESS | 30536 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:2.51 (3.6%) stddev-sans-first:2.65 06:48:49 INFO - PROCESS | 30536 | Values: 71.0 71.0 70.0 71.0 69.0 68.0 68.0 76.0 67.0 70.0 06:48:49 INFO - PROCESS | 30536 | -------- Summary: end -------- 06:48:49 INFO - PROCESS | 30536 | 06:48:50 INFO - TEST-INFO | 30536: exit 0 06:48:50 INFO - TEST-OK | kraken | took 64953ms 06:48:50 INFO - SUITE-END | took 1182s 06:48:50 INFO - Completed test suite (00:19:42) 06:48:50 INFO - javascript benchmark 06:48:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6438.5787355078555, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.579907214846, 2666.8133230673848, 2678.665166854143, 2684.892604295827, 2694.164808909237, 4746.976265118674, 4777.116233496806, 4784.712917224969, 4901.411830580335, 4954.578860796837, 4695.17834378984, 4810.44679861816, 4838.9032219355595, 4868.488808675092, 4891.8777030574165, 4424.668149888763, 4470.485894122185, 4561.794719237642, 4570.245909424941, 4579.175748365293, 548.2194682357086, 4364.803583838735, 4414.22751018572, 4426.601605855472, 4484.484284307314, 4451.376807246988, 4475.0, 4480.0, 4483.417155769762, 4518.2319005769095, 4484.282514797649, 4500.954990450086, 4507.842225522091, 4513.323001549761, 4549.749763762991, 4381.123775244963, 4414.293713005904, 4421.270490369086, 4425.867223983286, 4436.423264975532, 4733.408323959505, 4845.515448455161, 4854.757262136879, 4895.510448955111, 4944.0, 5171.741412929338, 5188.792448302063, 5204.869878253036, 5212.635115541913, 5265.710385928773, 5213.895722085575, 5265.131253343194, 5275.788968441258, 5288.0, 5352.143657014898, 4913.606911447076, 4914.017196560702, 4915.778789954425, 4916.0, 4916.8770780730765, 5262.342207224097, 5357.330333708286, 5381.192821076792, 5401.837944861661, 5408.810691625853, 5155.61332900034, 5199.896002079937, 5207.7916883325, 5207.947920520822, 5252.29094072303, 5291.365036195682, 5297.735113244323, 5301.655392399559, 5306.575473962073, 5350.143976963667, 5004.974975125101, 5103.157978933435, 5138.743062846843, 5194.0650682876685, 5241.606879484054, 5157.63896527247, 5162.870928226825, 5169.043726910533, 5190.740462976836, 5201.739913004335, 4445.777711114431, 4453.844115456009, 4467.620252278528, 4504.707194032443, 4513.774311284423, 3773.6792372648083, 3805.771653700787, 3812.7140464465274, 3831.578526362098, 3870.148567315186, 4426.601605855424, 4458.086092351125, 4476.932846007313, 4526.683132180716, 4573.862784116482, 5264.05247055526, 5279.155335146358, 5283.445238250005, 5295.285136506599, 5297.364316282071, 4418.359337895987, 4466.977665111654, 4530.207213737583, 4535.31970204472, 4551.0, 4714.151452738472, 4723.338732577442, 4751.429828420612, 4753.619710423158, 4799.544043315879, 4822.927656085231, 4947.975260123676, 4949.109160351171, 4951.0, 5018.924716129261, 5109.6678715883345, 5141.974290128525, 5161.458046905171, 5161.896762064663, 5188.118019936695, 4809.254565542346, 4837.661363704507, 4844.660873738804, 4845.733484658378, 4854.878628034327, 5042.647014708935, 5074.974625126851, 5083.415407228068, 5134.024535338273, 5180.792768289226, 5250.501202385767, 5289.312389389509, 5314.920276195783, 5321.733913304397, 5369.382521010134, 5070.569001634754, 5120.334356533627, 5130.769115389891, 5153.072446959433, 5190.636655434083, 4934.087193869145, 5028.22062580286, 5099.260607212008, 5125.92311115341, 5150.9227361588855, 5000.849974500771, 5045.646804723781, 5064.645474816727, 5081.136206844919, 5097.388313402415, 5217.6086793489885, 5217.634765566374, 5223.52988231061, 5224.6342756008235, 5231.529162375405, 4918.852434426973, 4983.4518202996915, 5029.798808047637, 5050.191969284897, 5089.982003599369], "value": 4763.978282872709, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.276888698391, 576.8644368573384, 581.1109003225066, 600.4115966352975, 622.315453001698, 36704.71533496328, 40785.38821917673, 40904.0, 40907.0, 41047.384289235684, 39979.40030899539, 40157.79921100398, 40269.59730402695, 40285.7985710071, 40583.59416405835, 7832.490888092284, 8035.517868927854, 8056.597170141469, 8065.475744076645, 8065.919340806576, 7867.8426431471335, 7941.523508589503, 7987.400944929124, 7999.040115186186, 8021.077576078738, 7991.600419979007, 8023.719169829057, 8056.758297251063, 8069.39479539034, 8070.475419097769, 7894.763157105296, 7924.722634707787, 7942.642581083836, 7956.6817327306835, 7971.60141992898, 7714.537127772352, 7821.256980586835, 7837.843243135162, 7865.68537258509, 7875.724349647792, 30727.539086913715, 39187.21625567473, 39578.0, 39637.80181099105, 39638.0, 2865.3409715765492, 3014.894478693235, 3058.2201538607737, 3295.0938491914676, 3566.4472006838982, 28587.85706071477, 29083.709162908523, 29219.853900730574, 29224.70775292241, 29265.0, 3392.8473218705217, 3395.6604339565847, 3424.4642777588056, 3448.6378930212218, 3479.234568394949, 221816.0, 225086.0, 225605.0, 225877.0, 226760.8661956696, 33043.3391332172, 33368.16579585481, 33384.833075834955, 33467.16332091717, 33486.66513334835, 33159.17102072467, 34340.48489272663, 34345.65654343474, 34348.0, 34510.82744586311, 14181.936354773434, 14190.361433735507, 14217.36021879018, 14293.070950388192, 14316.355763990645, 10744.73138171552, 10783.13734901206, 10783.676489705322, 10807.189460790472, 10829.566817327377, 18374.35689750852, 18444.907775461037, 18473.353432629792, 18481.90759046196, 18571.72142417865, 6965.33829286217, 7000.474964377692, 7015.526739384786, 7177.497575169792, 7216.96391518039, 788.7121200761795, 887.40100432208, 926.8887733472027, 934.444005816538, 953.2135987810084, 28141.296467588065, 28860.855695721806, 29147.41705165927, 29270.7072929268, 29514.262143446587, 972.4845831709206, 974.8537719342014, 989.8861630912393, 998.8551660009258, 1004.3271008424373, 14882.925585372004, 15357.539273821803, 15405.614859628598, 15550.922245388927, 15558.766618500731, 411262.0, 421399.0, 425322.0, 427084.0, 709862.0, 50869.74565127151, 51546.74226628918, 51726.0, 51853.74073129686, 51953.0, 1153.7461758413135, 1182.1665725663386, 1189.4290740444635, 1208.4561947123655, 1219.5000049979467, 28142.859285703442, 29225.269368265963, 29680.851595741882, 29844.0, 30321.0, 43628.34557481704, 44205.55794442014, 44231.0, 44316.778416107714, 44536.109277813615, 280565.0, 281832.0, 282051.0, 282122.0, 282388.0, 25930.870345648153, 26236.21291361262, 40806.79596601998, 42213.1557368857, 42277.0, 41798.791006044776, 44796.826567529395, 45938.32493400453, 46005.0, 46468.30297545472, 38479.216825517426, 38770.0307492315, 39468.0, 39637.60362396339, 40092.0, 37189.62810371862, 37920.241595168496, 38620.0, 38936.80531597324, 39302.0, 33785.0, 37411.0, 37792.055198620255, 38199.6180038196, 38415.23169536649, 34202.657973420944, 35635.643643563235, 36050.09874753047, 36195.095122622144, 36206.45690314595, 26762.330941726614, 26914.461710766067, 27099.0, 27141.86429067842, 27634.032808851593], "value": 17593.314402941673, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.75944357836676, 362.5287126735244, 363.1230578153758, 377.0648790998324, 379.06560328789527, 15757.84242157578, 16290.104044277576, 17001.2349444275, 17067.231974561142, 17167.484975450756, 15989.360425582992, 16168.35326586938, 17088.316467341323, 17089.316427342892, 17136.48590542286, 5031.496850314967, 5173.094708426029, 5196.844094677147, 5207.843764687065, 5255.369355677324, 3719.330520506308, 5073.188289873621, 5807.0998995155815, 6101.0848372744, 6104.450599446049, 6101.908471372911, 6106.908396374058, 6135.846603834895, 6162.599431036968, 6198.75204991802, 5076.416212135615, 5388.164834450667, 5403.2165336026255, 5457.399686034533, 5465.426130256305, 5188.948110518884, 5190.896182076337, 5276.5251127398715, 5332.786688532493, 5334.5732341412595, 18254.726179107325, 19588.314408995615, 19606.80393196064, 19819.207231710858, 20120.09459574308, 1849.713294439364, 2081.8646787958733, 2184.1809321504434, 2212.6791615215866, 2400.8439451435775, 8498.235158835734, 8704.347173961978, 8879.556022198864, 9007.324450666161, 9129.406588571721, 1600.3518574977154, 1667.374734474572, 1724.7378100303122, 1725.3098760495777, 1758.8364620328107, 40755.59244407577, 41141.38287925684, 41669.0, 68079.31920680829, 69398.0, 9716.785401824773, 9861.802763944681, 10094.545745441474, 10182.23633227511, 10214.0, 13851.722965540634, 13965.930170349084, 14003.71992560143, 14023.719525609431, 14059.156450612996, 6695.933040669628, 6747.460203183734, 6840.965795170992, 6881.793546193622, 6911.481638877104, 6212.223472065992, 6298.559100862987, 6397.840053998687, 6407.295197528269, 6409.487241020707, 4191.266528357586, 4209.705320627527, 4213.789310534461, 4365.345198220292, 4487.237169681162, 1556.820965588949, 1702.2425020865844, 1754.526277904984, 1778.7065134252703, 1816.4369045595909, 785.5286827903212, 846.9618867150994, 867.1588559097665, 871.172386233081, 934.0, 16606.50180494587, 16618.83381166197, 16737.748933766004, 16931.407400740914, 16994.490165294814, 840.4159109419018, 841.3857883744901, 852.7868032991752, 859.6002858670748, 884.8009197930543, 9501.714948551555, 9510.191633711212, 9541.332106752461, 9586.281028922858, 9741.707748767549, 391861.0, 403665.0, 410788.0, 414237.0, 416386.0, 72854.63572682103, 76332.61833690907, 77587.0, 78722.6063869677, 80351.59824200842, 883.5847151838625, 885.0706757904175, 892.5804871710286, 896.0636135238691, 897.0894542039835, 14828.258587070388, 15044.849551504783, 15116.244187790346, 15272.312745926682, 15305.392933742241, 36624.45063324105, 36988.44517332188, 37084.0, 37102.25795484129, 38528.42207366836, 45950.08099837918, 49731.0, 51101.488985109674, 51163.0, 51386.48613513817, 6958.338957799001, 7086.362227399352, 7097.183823860116, 7253.347198752138, 7576.772696819105, 10836.0, 11756.353400563052, 11851.52593896269, 11942.283462992249, 12255.75488490243, 10227.84658230142, 10375.0, 10508.0, 10660.0, 10716.571337146426, 10285.125764310118, 10348.534315955649, 10548.103411210133, 10611.575536978435, 10627.309224900357, 10323.690289291333, 10576.576936922436, 10674.946625267135, 10722.463876806285, 10748.0, 7362.190159082389, 7431.739889104072, 7480.251974802693, 7584.5070070445245, 7711.0746710395115, 9996.0, 10120.898791011996, 10209.846852297072, 10343.37939723619, 10555.52500137511], "value": 8101.268130892993, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.192884269438, 1374.656335916021, 1466.985330146699, 1674.7152983992721, 1681.302259562281, 7191.244919283478, 7668.079830420351, 7757.22427757224, 8211.096779354266, 8226.465279756812, 7764.340031097349, 8010.5594192319395, 8054.073781515128, 8064.395170362217, 8066.757997260077, 2213.7896899794573, 2255.23322070496, 2255.5939930812447, 2257.8306627002958, 2261.6381378979368, 2228.4317499037725, 2239.496113374486, 2298.37943755186, 2298.8965496552696, 2309.84985975911, 2240.7199100112484, 2243.2260869999823, 2246.0117548278786, 2254.718160229971, 2255.6954811100536, 2140.668196429556, 2153.364757396556, 2155.665871789867, 2162.0486985726307, 2170.533335332911, 2124.192806733447, 2126.1070350452846, 2143.710599069137, 2146.1844499090403, 2153.3001774423374, 7955.323797477221, 8067.112617612058, 8104.959475202645, 8125.837483250361, 8126.593670316461, 4461.732296062247, 4535.183666939949, 4595.540445955377, 4624.190766615829, 4626.21354369758, 2766.6443442713125, 2814.7888908331956, 2911.0, 2917.7957542972, 2937.3097322129283, 870.1863757386864, 891.0910870911698, 891.3092353426147, 913.5980168725806, 923.5382308845577, 10490.685279441628, 10686.358818470917, 10727.83908241377, 10778.514966826433, 10790.73023174419, 4127.174565086994, 4222.366645003212, 4302.247106756305, 4311.698181127291, 4316.482022157361, 8921.420107692978, 8973.28213742899, 9201.90798092024, 9225.953870230605, 9250.306227033, 4546.704464209815, 4568.200564901129, 4580.97709511457, 4582.08358328329, 4610.9308360374625, 3623.130448692295, 4110.671146308348, 4122.051928056564, 4174.91650166995, 4305.655547556188, 3641.708663306929, 3702.7593206441493, 3752.3996160614715, 3784.735068545175, 3798.6961043116485, 1179.628417048627, 1198.358878000283, 1200.5317926008863, 1210.8244304575787, 1220.4690959432498, 722.6170129831198, 812.7846120777998, 814.539785021461, 834.8163404051099, 836.7908022994252, 5065.265536497187, 5251.789928402897, 5262.052830490472, 5282.154855223146, 5285.0, 368.8874893157559, 383.26987089594365, 388.50077650219333, 400.3014739279975, 403.8303912356817, 3511.94732079019, 3524.788512689247, 3554.3424466473266, 3558.4128618777613, 3586.497890295361, 9369.906300936904, 9638.325317227867, 9750.853737193947, 9758.0, 9782.11960923506, 9527.47598882068, 9569.856452153223, 9639.228861691048, 9733.853992190123, 9736.610535578639, 7389.926100739031, 7415.443841711894, 7446.069241344832, 7475.6262186890435, 7508.0990281166605, 4983.775730092082, 5110.872228194325, 5186.585073194211, 5241.449647786927, 5254.7898084076205, 9066.365354425126, 9069.77325566866, 9101.135392137736, 9128.087191280818, 9136.725898223063, 8953.731388058368, 9145.131212534798, 9184.954075229849, 9343.906560934576, 9368.156865882103, 6065.514758819372, 6622.602643841385, 6755.121834161528, 6867.690953906987, 6901.344372284625, 7193.604351760703, 7281.745138920112, 7288.052553168054, 7361.779146625609, 7383.372413344926, 6494.188226471691, 6653.933460665331, 6703.731850725916, 6727.73089076451, 6817.454603631599, 6491.253505846888, 6527.934720652923, 6580.605163690194, 6651.800445986628, 6729.730810767514, 5949.7620095197435, 5954.821355359346, 6046.879062418639, 6058.727357269022, 6060.151578778887, 4449.822007119679, 4522.773861306987, 4551.431071116111, 4558.179527685049, 4614.423197100363, 4402.691811573287, 4514.210013247734, 4580.427446569179, 4592.402987611723, 4600.056988317454], "value": 4053.3432497282724, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.86796286704646, 286.805455278764, 291.7826219466498, 297.784106522771, 303.17687478495884, 5106.668066575679, 5120.615953803465, 5125.333706618139, 5126.2570725953165, 5149.524071251899, 5088.5143676581565, 5089.77845317124, 5092.134337162682, 5092.490750924906, 5125.436202017775, 3775.6413140751583, 3857.8071096445206, 3944.9408258876138, 3954.228925359556, 3962.6829853611644, 3940.0, 3950.3876899080688, 3980.1044764927806, 3985.6811455083525, 3999.1401848602545, 3946.796227150718, 3964.742291751027, 3977.2443235785254, 3977.423273625337, 3977.86077487288, 3731.067233191702, 3917.275304068728, 3936.4488971544006, 3986.740861843971, 3989.700772442064, 3446.3968805458944, 3449.1721986723255, 3466.3067386522544, 3476.5132881396626, 3494.982525087358, 4917.0, 4921.950780492185, 4987.825426110068, 4990.451050384455, 5012.147934851084, 4426.710081452666, 4553.954460455386, 4564.908701825978, 4577.9542204577865, 4596.3794887690065, 5255.710935898524, 5326.760295786699, 5337.6797392156595, 5344.625876188668, 5361.544268737162, 3817.1602247505502, 3849.9807500962597, 3855.749376290532, 3861.2470568239205, 3869.941950870711, 5485.917711234335, 5605.523530499912, 5631.802886898939, 5651.519620832234, 5677.148427735831, 3880.825362858678, 3889.747166434173, 3904.141088960424, 3907.941380879289, 3911.3155197840265, 3930.194310166409, 3957.3272543667645, 3962.841486340514, 3968.6825053995613, 3978.224246271949, 4492.303692927601, 4539.841105561355, 4544.7500387479, 4547.931781023221, 4600.7469589172915, 5145.276332428603, 5310.628256022042, 5313.1764576490705, 5319.1223448131395, 5344.278522399504, 1356.8982326325565, 1369.6986662934337, 1370.5545697648304, 1373.9725205495834, 1374.5807528703842, 849.755108765649, 868.1145231863591, 896.6682327538853, 902.0753727429307, 909.4725059465494, 4493.955060449353, 4584.404027476407, 4612.423447069116, 4676.625869930397, 4688.109259240733, 5542.334919809648, 5596.888062238732, 5601.551875849922, 5627.662340259598, 5629.0, 4472.888177795581, 4695.3191787191345, 4706.529347065266, 4732.503087175865, 4733.384659994247, 2954.3057381515328, 2994.460997020514, 3000.159955212544, 3003.2041509000132, 3008.819470831757, 5173.275741396207, 5193.844184674465, 5206.245094461282, 5213.556847667991, 5241.73791310433, 5386.91919621206, 5671.489565939085, 5678.432156784371, 5681.57388195887, 5700.4299570043495, 5207.9999999999245, 5209.0, 5219.556337711337, 5232.947670523322, 5245.763940622757, 5584.692841893735, 5594.552435805044, 5594.776208951596, 5613.298337707786, 5617.466340697627, 5275.314209152785, 5475.72621368938, 5492.148716948879, 5496.148097044965, 5524.4199359066715, 5178.61160412963, 5246.632735708464, 5249.475052494873, 5249.873801110556, 5275.393329767126, 3816.7137464689704, 3826.3303921814127, 3835.980820095882, 3847.2305538892892, 3853.8265778039495, 5379.73101344939, 5552.472515111058, 5552.472515111058, 5569.498745112959, 5570.108782594765, 5379.4082650907585, 5384.219288203267, 5389.8113566025, 5435.565154787687, 5438.537724293479, 5219.0, 5300.946990530199, 5312.468753124656, 5313.495217954288, 5389.865253368697, 5254.159334506614, 5278.81524146653, 5288.233206185005, 5296.682199068068, 5301.416844147064, 5195.896082078413, 5311.256424100707, 5455.563554915518, 5459.836204913859, 5464.644798088111, 5294.814681486284, 5312.574994000393, 5315.495027972336, 5324.600654950972, 5325.147976323769], "value": 4027.7325810776883, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.870425914817, 685.9607694343072, 690.454540912679, 707.5012116457898, 731.5903094267208, 12607.180533265342, 13833.239171845556, 13838.861611383883, 14278.428862845474, 14288.142711437322, 14605.707885842277, 14692.853071469282, 14696.191709456003, 14776.335064922077, 14793.334299956501, 621.4624349937294, 762.3824701991405, 789.6130895861015, 797.11520212564, 802.1657476224719, 795.8169620987177, 796.8605494038549, 797.6131576185575, 798.4490701416033, 801.5751651624648, 820.327331588098, 822.3256929317962, 826.1284345016036, 829.60179114025, 830.8421399934024, 816.2735165702529, 821.2157389692859, 823.5141266652673, 823.6869989404048, 824.2787560884167, 603.7253049862302, 606.7663949379477, 608.1000119822643, 608.5496732418023, 609.0285993839818, 13802.585922422344, 13802.930985345009, 13830.308484575731, 13832.30838458083, 13843.723125537434, 13041.478340866353, 13229.55643368489, 13354.465821367134, 13429.932850335686, 13469.393877275448, 10345.534450949724, 10436.84344734822, 10480.371177729285, 10528.105111065568, 10627.734306642396, 3322.60128784545, 3360.8319584020946, 3369.528266042756, 3375.4093033719, 3431.5024321473497, 44575.77712111451, 44746.0, 50570.49429505732, 56250.43749562493, 56816.0, 10206.948965255275, 10273.229507786946, 10345.496411750903, 10359.94820025895, 10422.322549034288, 18706.438806835817, 18759.0620468976, 18767.436976890716, 18853.52866178329, 18862.24551017944, 6589.800620380803, 6647.933520664828, 6724.740058734832, 6746.055552222692, 6803.829904252433, 3615.204654975901, 3631.5655316149973, 3639.6906262967414, 3668.9816550917076, 3694.07648087978, 2922.7369536741794, 2980.5231163013814, 3003.3692924486104, 3014.2464383904025, 3039.300960779033, 497.7536119620811, 502.87428142964256, 504.4703061785111, 506.2937202602349, 517.585931255002, 357.174925921123, 405.3473907009712, 471.7641179410295, 483.8887055977075, 498.80546586831167, 7505.737299194502, 7686.346660533805, 7756.263155000266, 7804.570748608768, 7820.608969551499, 406.2991339938582, 458.46817691477725, 468.50338641040605, 471.90797794429756, 487.87788087398843, 3740.532433445819, 3787.110029143149, 3807.9428808567895, 3858.5176852893387, 4038.495188101487, 91131.54434227786, 94353.52823235978, 94753.5262323684, 95031.52484237535, 96666.51666741761, 48349.274760878616, 48585.27122093172, 66383.33616663868, 68579.65710171417, 69562.3043769566, 70104.2989570108, 70111.64944175247, 70138.2986170142, 70626.0, 72969.0, 8726.0, 8786.868196977179, 9050.683226087056, 9094.317926155698, 9105.408148470327, 41942.58057419509, 42169.94575135646, 42276.0, 43373.78313108414, 44233.557664422944, 56518.434815651315, 57183.0, 61150.69424652848, 64300.0, 64828.675856620415, 10968.17738669587, 11057.11543076568, 11141.777164456827, 11153.330800152016, 11306.4912078955, 12589.496420143458, 12898.935505322788, 12995.155314904501, 13129.146605470614, 13132.868671313547, 11558.537658493902, 11806.232594881305, 11872.347020913932, 12147.81778273309, 12449.696806090902, 11619.0, 11927.522899084286, 12219.205751626116, 12276.938615306866, 12524.06069544806, 9796.363236389612, 11098.389588572705, 11216.66350009501, 11379.658610241706, 12356.443960022001, 9645.37305075196, 10642.255042146975, 10754.354738715701, 10964.232503724663, 11168.553257869595, 10038.297319187586, 10198.808047917213, 10420.114290285108, 10727.570897164025, 10776.568937242737], "value": 6426.112550812579, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 115.0, 113.0, 114.0, 114.0, 113.0, 113.0, 115.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 132.0, 156.0, 191.0, 133.0, 158.0, 163.0, 134.0, 204.0, 139.0], "value": 156.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 171.0, 169.0, 163.0, 161.0, 165.0, 163.0, 165.0, 162.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 174.0, 78.0, 76.0, 87.0, 76.0, 159.0, 78.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 148.0, 87.0, 87.0, 87.0, 129.0, 86.0, 86.0, 142.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 119.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 148.0, 149.0, 148.0, 150.0, 148.0, 148.0, 147.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 63.0, 64.0, 64.0, 63.0, 68.0, 64.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 87.0, 87.0, 86.0, 92.0, 86.0, 86.0, 113.0, 85.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 143.0, 133.0, 142.0, 136.0, 146.0, 134.0, 139.0, 133.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 172.0, 169.0, 172.0, 175.0, 176.0, 172.0, 174.0, 173.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 71.0, 69.0, 68.0, 68.0, 76.0, 67.0, 70.0], "value": 70.1, "unit": "score"}]}]} 06:48:50 INFO - Return code: 0 06:48:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:48:50 ERROR - # TBPL SUCCESS # 06:48:50 INFO - Running post-action listener: _resource_record_post_action 06:48:50 INFO - ##### 06:48:50 INFO - ##### Finished run-tests step (success) 06:48:50 INFO - ##### 06:48:50 INFO - Running post-run listener: _resource_record_post_run 06:48:50 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 541605888; Read time: 0; Write time: 563228 06:48:50 INFO - TinderboxPrint: CPU usage
13.4% 06:48:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:48:50 INFO - TinderboxPrint: I/O write bytes / time
541,605,888 / 563,228 06:48:50 INFO - TinderboxPrint: CPU idle
8,277.8 (86.5%) 06:48:50 INFO - TinderboxPrint: CPU user
1,229.5 (12.9%) 06:48:50 INFO - TinderboxPrint: Swap in / out
0 / 0 06:48:50 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 244883456; Read time: 0; Write time: 288700 06:48:50 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 296722432; Read time: 0; Write time: 274528 06:48:51 INFO - Running post-run listener: _upload_blobber_files 06:48:51 INFO - Blob upload gear active. 06:48:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:48:51 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 06:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:48:51 INFO - (blobuploader) - INFO - Open directory for files ... 06:48:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:48:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:52 INFO - (blobuploader) - INFO - Done attempting. 06:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:48:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:53 INFO - (blobuploader) - INFO - Done attempting. 06:48:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:48:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:57 INFO - (blobuploader) - INFO - Done attempting. 06:48:57 INFO - (blobuploader) - INFO - Iteration through files over. 06:48:57 INFO - Return code: 0 06:48:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:48:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:48:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc36bac36789d6d7c6e8b69850bb9edde265a78ad0ee5ef3b3c3b80619892ac84d8631077ad4051c2df76b604a9b57a721e7eaef5b1b4c5d36c64c5a775a4128", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa9073434dbbeeb2c15aee2ea3ef6f1d3c545cbfd1642a5a615b1c66328189d5166512afd3caf791a969a327caaea4b1fe7e5f33c5b9f86f928605ac6de96066", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a9ba2addb8c2f6f3ed43e204476d12fd6c61b7c61d387ff15f6c46cb96a0ad9ac43de2fe014b4ed1b62f8b1a5ba34ab25bf82f36d68fb427e1c0760eca2cf5d"} 06:48:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:48:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:48:57 INFO - Contents: 06:48:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc36bac36789d6d7c6e8b69850bb9edde265a78ad0ee5ef3b3c3b80619892ac84d8631077ad4051c2df76b604a9b57a721e7eaef5b1b4c5d36c64c5a775a4128", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa9073434dbbeeb2c15aee2ea3ef6f1d3c545cbfd1642a5a615b1c66328189d5166512afd3caf791a969a327caaea4b1fe7e5f33c5b9f86f928605ac6de96066", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a9ba2addb8c2f6f3ed43e204476d12fd6c61b7c61d387ff15f6c46cb96a0ad9ac43de2fe014b4ed1b62f8b1a5ba34ab25bf82f36d68fb427e1c0760eca2cf5d"} 06:48:57 INFO - Running post-run listener: copy_logs_to_upload_dir 06:48:57 INFO - Copying logs to upload dir... 06:48:57 INFO - mkdir: /builds/slave/test/build/upload/logs 06:48:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.893699 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-17 06:48:57.674458) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 06:48:57.678206) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905 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-Non-PGO/sha512/dc36bac36789d6d7c6e8b69850bb9edde265a78ad0ee5ef3b3c3b80619892ac84d8631077ad4051c2df76b604a9b57a721e7eaef5b1b4c5d36c64c5a775a4128", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa9073434dbbeeb2c15aee2ea3ef6f1d3c545cbfd1642a5a615b1c66328189d5166512afd3caf791a969a327caaea4b1fe7e5f33c5b9f86f928605ac6de96066", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a9ba2addb8c2f6f3ed43e204476d12fd6c61b7c61d387ff15f6c46cb96a0ad9ac43de2fe014b4ed1b62f8b1a5ba34ab25bf82f36d68fb427e1c0760eca2cf5d"} build_url:https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010388 build_url: 'https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc36bac36789d6d7c6e8b69850bb9edde265a78ad0ee5ef3b3c3b80619892ac84d8631077ad4051c2df76b604a9b57a721e7eaef5b1b4c5d36c64c5a775a4128", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa9073434dbbeeb2c15aee2ea3ef6f1d3c545cbfd1642a5a615b1c66328189d5166512afd3caf791a969a327caaea4b1fe7e5f33c5b9f86f928605ac6de96066", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a9ba2addb8c2f6f3ed43e204476d12fd6c61b7c61d387ff15f6c46cb96a0ad9ac43de2fe014b4ed1b62f8b1a5ba34ab25bf82f36d68fb427e1c0760eca2cf5d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 06:48:57.703635) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:48:57.704044) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466170073.185402-1439495905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004693 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:48:57.789887) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 06:48:57.790237) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 06:48:57.790553) ========= ========= Total master_lag: 0.32 =========