builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1470106797.57 results: success (0) buildid: 20160801173002 builduid: 49ae444e35764bf2950ecf54de8ef8c8 revision: bdfe8fd853b927c7d4fc3a45237f4cd35e49e86c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:57.573309) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:57.574008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:57.574301) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:57.645191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:57.645489) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 19:59:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-08-01 19:59:57 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.213417 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:57.906524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:57.906805) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.071687 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:57.990447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:57.990797) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bdfe8fd853b927c7d4fc3a45237f4cd35e49e86c --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 bdfe8fd853b927c7d4fc3a45237f4cd35e49e86c --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=934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 19:59:58,074 truncating revision to first 12 chars 2016-08-01 19:59:58,074 Setting DEBUG logging. 2016-08-01 19:59:58,074 attempt 1/10 2016-08-01 19:59:58,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bdfe8fd853b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 19:59:58,483 unpacking tar archive at: fx-team-bdfe8fd853b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.743061 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:58.747602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:58.747906) ========= script_repo_revision: bdfe8fd853b927c7d4fc3a45237f4cd35e49e86c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:58.748290) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:58.748573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 19:59:58.757216) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-01 19:59:58.757580) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:59:59 INFO - MultiFileLogger online at 20160801 19:59:59 in /builds/slave/test 19:59:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:59:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:59:59 INFO - {'append_to_log': False, 19:59:59 INFO - 'base_work_dir': '/builds/slave/test', 19:59:59 INFO - 'blob_upload_branch': 'Fx-Team', 19:59:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:59:59 INFO - 'branch': 'Fx-Team', 19:59:59 INFO - 'buildbot_json_path': 'buildprops.json', 19:59:59 INFO - 'config_files': ('talos/linux_config.py',), 19:59:59 INFO - 'default_actions': ('clobber', 19:59:59 INFO - 'read-buildbot-config', 19:59:59 INFO - 'download-and-extract', 19:59:59 INFO - 'populate-webroot', 19:59:59 INFO - 'create-virtualenv', 19:59:59 INFO - 'install', 19:59:59 INFO - 'run-tests'), 19:59:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:59:59 INFO - 'download_minidump_stackwalk': True, 19:59:59 INFO - 'download_symbols': 'ondemand', 19:59:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:59:59 INFO - 'tooltool.py': '/tools/tooltool.py', 19:59:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:59:59 INFO - '/tools/misc-python/virtualenv.py')}, 19:59:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:59:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:59:59 INFO - 'installer_path': 'installer.exe', 19:59:59 INFO - 'log_level': 'info', 19:59:59 INFO - 'log_name': 'talos', 19:59:59 INFO - 'log_to_console': True, 19:59:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:59:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:59:59 INFO - 'opt_config_files': (), 19:59:59 INFO - 'pip_index': False, 19:59:59 INFO - 'sps_profile': False, 19:59:59 INFO - 'sps_profile_interval': 0, 19:59:59 INFO - 'suite': 'dromaeojs-e10s', 19:59:59 INFO - 'system_bits': '32', 19:59:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:59:59 INFO - 'title': 'talos-linux64-ix-057', 19:59:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:59:59 INFO - 'use_talos_json': True, 19:59:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:59:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:59:59 INFO - 'work_dir': 'build'} 19:59:59 INFO - [mozharness: 2016-08-02 02:59:59.049729Z] Running clobber step. 19:59:59 INFO - Running pre-action listener: _resource_record_pre_action 19:59:59 INFO - Running main action method: clobber 19:59:59 INFO - rmtree: /builds/slave/test/build 19:59:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:00:00 INFO - Running post-action listener: _resource_record_post_action 20:00:00 INFO - [mozharness: 2016-08-02 03:00:00.958408Z] Finished clobber step (success) 20:00:00 INFO - [mozharness: 2016-08-02 03:00:00.958564Z] Running read-buildbot-config step. 20:00:00 INFO - Running pre-action listener: _resource_record_pre_action 20:00:00 INFO - Running main action method: read_buildbot_config 20:00:00 INFO - Using buildbot properties: 20:00:00 INFO - { 20:00:00 INFO - "project": "", 20:00:00 INFO - "product": "firefox", 20:00:00 INFO - "script_repo_revision": "production", 20:00:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:00:00 INFO - "repository": "", 20:00:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:00:00 INFO - "buildid": "20160801173002", 20:00:00 INFO - "pgo_build": "True", 20:00:00 INFO - "basedir": "/builds/slave/test", 20:00:00 INFO - "buildnumber": 999, 20:00:00 INFO - "slavename": "talos-linux64-ix-057", 20:00:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:00:00 INFO - "platform": "ubuntu64_hw", 20:00:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:00:00 INFO - "branch": "fx-team", 20:00:00 INFO - "repo_path": "integration/fx-team", 20:00:00 INFO - "revision": "bdfe8fd853b927c7d4fc3a45237f4cd35e49e86c", 20:00:00 INFO - "stage_platform": "linux64-pgo", 20:00:00 INFO - "builduid": "49ae444e35764bf2950ecf54de8ef8c8", 20:00:00 INFO - "slavebuilddir": "test" 20:00:00 INFO - } 20:00:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:00:00 INFO - Running post-action listener: _resource_record_post_action 20:00:00 INFO - [mozharness: 2016-08-02 03:00:00.962463Z] Finished read-buildbot-config step (success) 20:00:00 INFO - [mozharness: 2016-08-02 03:00:00.962604Z] Running download-and-extract step. 20:00:00 INFO - Running pre-action listener: _resource_record_pre_action 20:00:00 INFO - Running main action method: download_and_extract 20:00:00 INFO - mkdir: /builds/slave/test/build/tests 20:00:00 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')]} 20:00:00 INFO - https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:00:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:00:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:00:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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 20:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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 20:00:01 INFO - Downloaded 1361 bytes. 20:00:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:00:01 INFO - Using the following test package requirements: 20:00:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:00:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:00:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:01 INFO - u'jsshell-linux-x86_64.zip'], 20:00:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:00:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:00:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:00:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:00:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:00:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:00:01 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')]} 20:00:01 INFO - https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:00:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:00:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:00:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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 20:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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 20:00:02 INFO - Downloaded 21809163 bytes. 20:00:02 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'] 20:00:02 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 20:00:04 INFO - Return code: 0 20:00:04 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 20:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:04 INFO - https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:00:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:00:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:00:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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 20:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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 20:00:07 INFO - Downloaded 21809163 bytes. 20:00:07 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'] 20:00:07 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 20:00:08 INFO - Return code: 0 20:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:08 INFO - https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:00:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:00:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:00:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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 20:00:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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 20:00:09 INFO - Downloaded 14413723 bytes. 20:00:09 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'] 20:00:09 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 20:00:09 INFO - Return code: 0 20:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:09 INFO - https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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 20:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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 20:00:11 INFO - Downloaded 59370937 bytes. 20:00:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:00:11 INFO - mkdir: /builds/slave/test/properties 20:00:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:00:11 INFO - Writing to file /builds/slave/test/properties/build_url 20:00:11 INFO - Contents: 20:00:11 INFO - build_url:https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:00:11 INFO - Running post-action listener: _resource_record_post_action 20:00:11 INFO - Running post-action listener: set_extra_try_arguments 20:00:11 INFO - [mozharness: 2016-08-02 03:00:11.857133Z] Finished download-and-extract step (success) 20:00:11 INFO - [mozharness: 2016-08-02 03:00:11.857405Z] Running populate-webroot step. 20:00:11 INFO - Running pre-action listener: _resource_record_pre_action 20:00:11 INFO - Running main action method: populate_webroot 20:00:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:00:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:00:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:00:11 INFO - '--tppagecycles', 20:00:11 INFO - '7'], 20:00:11 INFO - 'tests': ['tsvgm']}}, 20:00:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:00:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:00:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:00:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:00:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:11 INFO - 'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:00:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:00:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:11 INFO - 'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['damp', 'tps']}, 20:00:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:11 INFO - 'tests': ['damp', 'tps']}, 20:00:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['dromaeo_dom']}, 20:00:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:00:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['basic_compositor_video']}, 20:00:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:00:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['a11yr', 20:00:11 INFO - 'ts_paint', 20:00:11 INFO - 'tpaint', 20:00:11 INFO - 'sessionrestore', 20:00:11 INFO - 'sessionrestore_no_auto_restore', 20:00:11 INFO - 'tabpaint']}, 20:00:11 INFO - 'other-e10s': {'tests': ['a11yr', 20:00:11 INFO - 'ts_paint', 20:00:11 INFO - 'tpaint', 20:00:11 INFO - 'sessionrestore', 20:00:11 INFO - 'sessionrestore_no_auto_restore', 20:00:11 INFO - 'tabpaint']}, 20:00:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:00:11 INFO - 'ts_paint', 20:00:11 INFO - 'tpaint', 20:00:11 INFO - 'sessionrestore', 20:00:11 INFO - 'sessionrestore_no_auto_restore', 20:00:11 INFO - 'tabpaint']}, 20:00:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:00:11 INFO - 'ts_paint', 20:00:11 INFO - 'tpaint', 20:00:11 INFO - 'sessionrestore', 20:00:11 INFO - 'sessionrestore_no_auto_restore', 20:00:11 INFO - 'tabpaint']}, 20:00:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['a11yr', 20:00:11 INFO - 'ts_paint', 20:00:11 INFO - 'tpaint', 20:00:11 INFO - 'sessionrestore', 20:00:11 INFO - 'sessionrestore_no_auto_restore', 20:00:11 INFO - 'tabpaint']}, 20:00:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['a11yr', 20:00:11 INFO - 'ts_paint', 20:00:11 INFO - 'tpaint', 20:00:11 INFO - 'sessionrestore', 20:00:11 INFO - 'sessionrestore_no_auto_restore', 20:00:11 INFO - 'tabpaint']}, 20:00:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['tsvgx', 20:00:11 INFO - 'tsvgr_opacity', 20:00:11 INFO - 'tart', 20:00:11 INFO - 'tscrollx', 20:00:11 INFO - 'cart']}, 20:00:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:00:11 INFO - 'tsvgr_opacity', 20:00:11 INFO - 'tart', 20:00:11 INFO - 'tscrollx', 20:00:11 INFO - 'cart']}, 20:00:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:11 INFO - 'talos_options': ['--disable-e10s'], 20:00:11 INFO - 'tests': ['tp5o']}, 20:00:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:11 INFO - 'tests': ['tp5o']}, 20:00:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:11 INFO - 'talos_options': ['--disable-e10s', 20:00:11 INFO - '--xperf_path', 20:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:00:11 INFO - 'tests': ['tp5n']}, 20:00:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:11 INFO - 'talos_options': ['--xperf_path', 20:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:00:11 INFO - 'tests': ['tp5n']}}, 20:00:11 INFO - 'talos.zip': {'path': '', 20:00:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:00:11 INFO - Running post-action listener: _resource_record_post_action 20:00:11 INFO - [mozharness: 2016-08-02 03:00:11.875615Z] Finished populate-webroot step (success) 20:00:11 INFO - [mozharness: 2016-08-02 03:00:11.875703Z] Running create-virtualenv step. 20:00:11 INFO - Running pre-action listener: _resource_record_pre_action 20:00:11 INFO - Running main action method: create_virtualenv 20:00:11 INFO - Creating virtualenv /builds/slave/test/build/venv 20:00:11 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 20:00:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:00:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:00:12 INFO - Using real prefix '/usr' 20:00:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:00:12 INFO - Installing distribute.............................................................................................................................................................................................done. 20:00:14 INFO - Installing pip.................done. 20:00:14 INFO - Return code: 0 20:00:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:00:14 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')]} 20:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:14 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')]} 20:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:14 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 0x2789030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', '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 20:00:14 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 20:00:14 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 20:00:14 INFO - Using env: {'DISPLAY': ':0', 20:00:14 INFO - 'HOME': '/home/cltbld', 20:00:14 INFO - 'LANG': 'en_US.UTF-8', 20:00:14 INFO - 'LANGUAGE': 'en_US:en', 20:00:14 INFO - 'LOGNAME': 'cltbld', 20:00:14 INFO - 'MAIL': '/var/mail/cltbld', 20:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:14 INFO - 'MOZ_NO_REMOTE': '1', 20:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:14 INFO - 'NO_EM_RESTART': '1', 20:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:14 INFO - 'PWD': '/builds/slave/test', 20:00:14 INFO - 'SHELL': '/bin/bash', 20:00:14 INFO - 'SHLVL': '1', 20:00:14 INFO - 'TERM': 'linux', 20:00:14 INFO - 'TMOUT': '86400', 20:00:14 INFO - 'USER': 'cltbld', 20:00:14 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:14 INFO - '_': '/tools/buildbot/bin/python'} 20:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:15 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 20:00:15 INFO - Cleaning up... 20:00:15 INFO - Return code: 0 20:00:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:00:15 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')]} 20:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:15 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')]} 20:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:15 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 0x2789030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', '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 20:00:15 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 20:00:15 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 20:00:15 INFO - Using env: {'DISPLAY': ':0', 20:00:15 INFO - 'HOME': '/home/cltbld', 20:00:15 INFO - 'LANG': 'en_US.UTF-8', 20:00:15 INFO - 'LANGUAGE': 'en_US:en', 20:00:15 INFO - 'LOGNAME': 'cltbld', 20:00:15 INFO - 'MAIL': '/var/mail/cltbld', 20:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:15 INFO - 'MOZ_NO_REMOTE': '1', 20:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:15 INFO - 'NO_EM_RESTART': '1', 20:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:15 INFO - 'PWD': '/builds/slave/test', 20:00:15 INFO - 'SHELL': '/bin/bash', 20:00:15 INFO - 'SHLVL': '1', 20:00:15 INFO - 'TERM': 'linux', 20:00:15 INFO - 'TMOUT': '86400', 20:00:15 INFO - 'USER': 'cltbld', 20:00:15 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:15 INFO - '_': '/tools/buildbot/bin/python'} 20:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:15 INFO - Downloading/unpacking psutil>=3.1.1 20:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:00:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:00:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:00:17 INFO - Installing collected packages: psutil 20:00:17 INFO - Running setup.py install for psutil 20:00:17 INFO - building 'psutil._psutil_linux' extension 20:00:17 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 20:00:18 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 20:00:18 INFO - building 'psutil._psutil_posix' extension 20:00:18 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 20:00:18 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 20:00:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:00:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:00:19 INFO - Successfully installed psutil 20:00:19 INFO - Cleaning up... 20:00:19 INFO - Return code: 0 20:00:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:19 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 0x2789030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', '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 20:00:19 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 20:00:19 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 20:00:19 INFO - Using env: {'DISPLAY': ':0', 20:00:19 INFO - 'HOME': '/home/cltbld', 20:00:19 INFO - 'LANG': 'en_US.UTF-8', 20:00:19 INFO - 'LANGUAGE': 'en_US:en', 20:00:19 INFO - 'LOGNAME': 'cltbld', 20:00:19 INFO - 'MAIL': '/var/mail/cltbld', 20:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:19 INFO - 'MOZ_NO_REMOTE': '1', 20:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:19 INFO - 'NO_EM_RESTART': '1', 20:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:19 INFO - 'PWD': '/builds/slave/test', 20:00:19 INFO - 'SHELL': '/bin/bash', 20:00:19 INFO - 'SHLVL': '1', 20:00:19 INFO - 'TERM': 'linux', 20:00:19 INFO - 'TMOUT': '86400', 20:00:19 INFO - 'USER': 'cltbld', 20:00:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:19 INFO - '_': '/tools/buildbot/bin/python'} 20:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:00:19 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 20:00:19 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 20:00:19 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 20:00:19 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 20:00:19 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 20:00:19 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 20:00:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:00:21 INFO - Installing collected packages: mozsystemmonitor 20:00:21 INFO - Running setup.py install for mozsystemmonitor 20:00:21 INFO - Successfully installed mozsystemmonitor 20:00:21 INFO - Cleaning up... 20:00:21 INFO - Return code: 0 20:00:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:00: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')]} 20:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00: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')]} 20:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:21 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 0x2789030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', '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 20:00:21 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 20:00:21 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 20:00:21 INFO - Using env: {'DISPLAY': ':0', 20:00:21 INFO - 'HOME': '/home/cltbld', 20:00:21 INFO - 'LANG': 'en_US.UTF-8', 20:00:21 INFO - 'LANGUAGE': 'en_US:en', 20:00:21 INFO - 'LOGNAME': 'cltbld', 20:00:21 INFO - 'MAIL': '/var/mail/cltbld', 20:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:21 INFO - 'MOZ_NO_REMOTE': '1', 20:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:21 INFO - 'NO_EM_RESTART': '1', 20:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:21 INFO - 'PWD': '/builds/slave/test', 20:00:21 INFO - 'SHELL': '/bin/bash', 20:00:21 INFO - 'SHLVL': '1', 20:00:21 INFO - 'TERM': 'linux', 20:00:21 INFO - 'TMOUT': '86400', 20:00:21 INFO - 'USER': 'cltbld', 20:00:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:21 INFO - '_': '/tools/buildbot/bin/python'} 20:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:21 INFO - Downloading/unpacking jsonschema==2.5.1 20:00:21 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 20:00:21 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 20:00:21 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 20:00:21 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 20:00:21 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 20:00:21 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 20:00:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:00:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:00:23 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 20:00:23 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 20:00:23 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 20:00:23 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 20:00:23 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 20:00:23 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 20:00:23 INFO - Downloading functools32-3.2.3-2.tar.gz 20:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:00:23 INFO - warning: no files found matching '*.txt' 20:00:23 INFO - no previously-included directories found matching 'build' 20:00:23 INFO - no previously-included directories found matching 'dist' 20:00:23 INFO - no previously-included directories found matching '.git*' 20:00:23 INFO - Installing collected packages: jsonschema, functools32 20:00:23 INFO - Running setup.py install for functools32 20:00:23 INFO - warning: no files found matching '*.txt' 20:00:23 INFO - no previously-included directories found matching 'build' 20:00:23 INFO - no previously-included directories found matching 'dist' 20:00:23 INFO - no previously-included directories found matching '.git*' 20:00:23 INFO - Successfully installed jsonschema functools32 20:00:23 INFO - Cleaning up... 20:00:23 INFO - Return code: 0 20:00:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2789030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', '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 20:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:00:23 INFO - Using env: {'DISPLAY': ':0', 20:00:23 INFO - 'HOME': '/home/cltbld', 20:00:23 INFO - 'LANG': 'en_US.UTF-8', 20:00:23 INFO - 'LANGUAGE': 'en_US:en', 20:00:23 INFO - 'LOGNAME': 'cltbld', 20:00:24 INFO - 'MAIL': '/var/mail/cltbld', 20:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:24 INFO - 'MOZ_NO_REMOTE': '1', 20:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:24 INFO - 'NO_EM_RESTART': '1', 20:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:24 INFO - 'PWD': '/builds/slave/test', 20:00:24 INFO - 'SHELL': '/bin/bash', 20:00:24 INFO - 'SHLVL': '1', 20:00:24 INFO - 'TERM': 'linux', 20:00:24 INFO - 'TMOUT': '86400', 20:00:24 INFO - 'USER': 'cltbld', 20:00:24 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:24 INFO - '_': '/tools/buildbot/bin/python'} 20:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:00:24 INFO - Cleaning up... 20:00:24 INFO - Return code: 0 20:00:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2789030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', '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 20:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:00:24 INFO - Using env: {'DISPLAY': ':0', 20:00:24 INFO - 'HOME': '/home/cltbld', 20:00:24 INFO - 'LANG': 'en_US.UTF-8', 20:00:24 INFO - 'LANGUAGE': 'en_US:en', 20:00:24 INFO - 'LOGNAME': 'cltbld', 20:00:24 INFO - 'MAIL': '/var/mail/cltbld', 20:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:24 INFO - 'MOZ_NO_REMOTE': '1', 20:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:24 INFO - 'NO_EM_RESTART': '1', 20:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:24 INFO - 'PWD': '/builds/slave/test', 20:00:24 INFO - 'SHELL': '/bin/bash', 20:00:24 INFO - 'SHLVL': '1', 20:00:24 INFO - 'TERM': 'linux', 20:00:24 INFO - 'TMOUT': '86400', 20:00:24 INFO - 'USER': 'cltbld', 20:00:24 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:24 INFO - '_': '/tools/buildbot/bin/python'} 20:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:24 INFO - Downloading/unpacking blobuploader==1.2.4 20:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:26 INFO - Downloading blobuploader-1.2.4.tar.gz 20:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:00:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:00:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:26 INFO - Downloading docopt-0.6.1.tar.gz 20:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:00:27 INFO - Installing collected packages: blobuploader, requests, docopt 20:00:27 INFO - Running setup.py install for blobuploader 20:00:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:00:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:00:27 INFO - Running setup.py install for requests 20:00:27 INFO - Running setup.py install for docopt 20:00:27 INFO - Successfully installed blobuploader requests docopt 20:00:27 INFO - Cleaning up... 20:00:27 INFO - Return code: 0 20:00:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:27 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 0x2789030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', '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 20:00:27 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 20:00:27 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 20:00:27 INFO - Using env: {'DISPLAY': ':0', 20:00:27 INFO - 'HOME': '/home/cltbld', 20:00:27 INFO - 'LANG': 'en_US.UTF-8', 20:00:27 INFO - 'LANGUAGE': 'en_US:en', 20:00:27 INFO - 'LOGNAME': 'cltbld', 20:00:27 INFO - 'MAIL': '/var/mail/cltbld', 20:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:27 INFO - 'MOZ_NO_REMOTE': '1', 20:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:27 INFO - 'NO_EM_RESTART': '1', 20:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:27 INFO - 'PWD': '/builds/slave/test', 20:00:27 INFO - 'SHELL': '/bin/bash', 20:00:27 INFO - 'SHLVL': '1', 20:00:27 INFO - 'TERM': 'linux', 20:00:27 INFO - 'TMOUT': '86400', 20:00:27 INFO - 'USER': 'cltbld', 20:00:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:27 INFO - '_': '/tools/buildbot/bin/python'} 20:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:00:27 INFO - Running setup.py (path:/tmp/pip-IdWf2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:00:27 INFO - Running setup.py (path:/tmp/pip-nzN9d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:00:28 INFO - Running setup.py (path:/tmp/pip-2eE9kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:00:28 INFO - Running setup.py (path:/tmp/pip-xthuFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:00:28 INFO - Running setup.py (path:/tmp/pip-1ZICUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:00:28 INFO - Running setup.py (path:/tmp/pip-Fc3QVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:00:28 INFO - Running setup.py (path:/tmp/pip-9HEnBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:00:28 INFO - Running setup.py (path:/tmp/pip-jXLqoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:00:28 INFO - Running setup.py (path:/tmp/pip-5iLBZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:00:28 INFO - Running setup.py (path:/tmp/pip-rAAORr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:00:28 INFO - Running setup.py (path:/tmp/pip-vC8FdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:00:28 INFO - Running setup.py (path:/tmp/pip-GZ7gNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:00:28 INFO - Running setup.py (path:/tmp/pip-Ul2DVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:00:28 INFO - Running setup.py (path:/tmp/pip-FpkaQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:28 INFO - Running setup.py (path:/tmp/pip-n_zifm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:00:28 INFO - Running setup.py (path:/tmp/pip-qVuVw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:00:29 INFO - Running setup.py (path:/tmp/pip-dlaURr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:00:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:00:29 INFO - Running setup.py install for manifestparser 20:00:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:00:29 INFO - Running setup.py install for mozcrash 20:00:29 INFO - Running setup.py install for mozdebug 20:00:29 INFO - Running setup.py install for mozdevice 20:00:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:00:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:00:29 INFO - Running setup.py install for mozfile 20:00:29 INFO - Running setup.py install for mozhttpd 20:00:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:00:29 INFO - Running setup.py install for mozinfo 20:00:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:00:29 INFO - Running setup.py install for mozInstall 20:00:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:00:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:00:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:00:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:00:29 INFO - Running setup.py install for mozleak 20:00:29 INFO - Running setup.py install for mozlog 20:00:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:00:30 INFO - Running setup.py install for moznetwork 20:00:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:00:30 INFO - Running setup.py install for mozprocess 20:00:30 INFO - Running setup.py install for mozprofile 20:00:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:00:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:00:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:00:30 INFO - Running setup.py install for mozrunner 20:00:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:00:30 INFO - Running setup.py install for mozscreenshot 20:00:30 INFO - Running setup.py install for moztest 20:00:30 INFO - Running setup.py install for mozversion 20:00:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:00:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:00:30 INFO - Cleaning up... 20:00:30 INFO - Return code: 0 20:00:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:30 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 0x2789030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', '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 20:00:30 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 20:00:30 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 20:00:30 INFO - Using env: {'DISPLAY': ':0', 20:00:30 INFO - 'HOME': '/home/cltbld', 20:00:30 INFO - 'LANG': 'en_US.UTF-8', 20:00:30 INFO - 'LANGUAGE': 'en_US:en', 20:00:30 INFO - 'LOGNAME': 'cltbld', 20:00:30 INFO - 'MAIL': '/var/mail/cltbld', 20:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:30 INFO - 'MOZ_NO_REMOTE': '1', 20:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:30 INFO - 'NO_EM_RESTART': '1', 20:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:30 INFO - 'PWD': '/builds/slave/test', 20:00:30 INFO - 'SHELL': '/bin/bash', 20:00:30 INFO - 'SHLVL': '1', 20:00:30 INFO - 'TERM': 'linux', 20:00:30 INFO - 'TMOUT': '86400', 20:00:30 INFO - 'USER': 'cltbld', 20:00:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:30 INFO - '_': '/tools/buildbot/bin/python'} 20:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:00:31 INFO - Running setup.py (path:/tmp/pip-yjYLU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:00:31 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:00:31 INFO - Running setup.py (path:/tmp/pip-TgjMI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:00:31 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:00:31 INFO - Running setup.py (path:/tmp/pip-GbsLug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:00:31 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:00:31 INFO - Running setup.py (path:/tmp/pip-Lh9TzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:00:31 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:00:31 INFO - Running setup.py (path:/tmp/pip-Yc6OcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:00:31 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:00:31 INFO - Running setup.py (path:/tmp/pip-T8IScX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:00:31 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:00:31 INFO - Running setup.py (path:/tmp/pip-bVXH8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:00:31 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:00:31 INFO - Running setup.py (path:/tmp/pip-v7Ep1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:00:31 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:00:31 INFO - Running setup.py (path:/tmp/pip-w42ZPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:00:31 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:00:31 INFO - Running setup.py (path:/tmp/pip-98RBOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:00:31 INFO - Running setup.py (path:/tmp/pip-lUVsTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:00:31 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)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:00:31 INFO - Running setup.py (path:/tmp/pip-FFHE91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:00:31 INFO - Running setup.py (path:/tmp/pip-YaTtSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:00:32 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)) 20:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:00:32 INFO - Running setup.py (path:/tmp/pip-LKXFIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:32 INFO - Running setup.py (path:/tmp/pip-nzpZqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:32 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)) 20:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:00:32 INFO - Running setup.py (path:/tmp/pip-GfYZi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:00:32 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)) 20:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:00:32 INFO - Running setup.py (path:/tmp/pip-BBQ4Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:00:32 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)) 20:00:32 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)) 20:00:32 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)) 20:00:32 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)) 20:00:32 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)) 20:00:32 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)) 20:00:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:34 INFO - Downloading blessings-1.6.tar.gz 20:00:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:00:34 INFO - Installing collected packages: blessings 20:00:34 INFO - Running setup.py install for blessings 20:00:34 INFO - Successfully installed blessings 20:00:34 INFO - Cleaning up... 20:00:34 INFO - Return code: 0 20:00:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:00:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:34 INFO - Reading from file tmpfile_stdout 20:00:34 INFO - Current package versions: 20:00:34 INFO - argparse == 1.2.1 20:00:34 INFO - blessings == 1.6 20:00:34 INFO - blobuploader == 1.2.4 20:00:34 INFO - docopt == 0.6.1 20:00:34 INFO - functools32 == 3.2.3-2 20:00:34 INFO - jsonschema == 2.5.1 20:00:34 INFO - manifestparser == 1.1 20:00:34 INFO - mozInstall == 1.12 20:00:34 INFO - mozcrash == 0.17 20:00:34 INFO - mozdebug == 0.1 20:00:34 INFO - mozdevice == 0.48 20:00:34 INFO - mozfile == 1.2 20:00:34 INFO - mozhttpd == 0.7 20:00:34 INFO - mozinfo == 0.9 20:00:34 INFO - mozleak == 0.1 20:00:34 INFO - mozlog == 3.3 20:00:34 INFO - moznetwork == 0.27 20:00:34 INFO - mozprocess == 0.23 20:00:34 INFO - mozprofile == 0.28 20:00:34 INFO - mozrunner == 6.12 20:00:34 INFO - mozscreenshot == 0.1 20:00:34 INFO - mozsystemmonitor == 0.3 20:00:34 INFO - moztest == 0.7 20:00:34 INFO - mozversion == 1.4 20:00:34 INFO - psutil == 3.1.1 20:00:34 INFO - requests == 1.2.3 20:00:34 INFO - wsgiref == 0.1.2 20:00:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:34 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')]} 20:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:34 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')]} 20:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:34 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 0x2789030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', '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 20:00:34 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 20:00:34 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 20:00:34 INFO - Using env: {'DISPLAY': ':0', 20:00:34 INFO - 'HOME': '/home/cltbld', 20:00:34 INFO - 'LANG': 'en_US.UTF-8', 20:00:34 INFO - 'LANGUAGE': 'en_US:en', 20:00:34 INFO - 'LOGNAME': 'cltbld', 20:00:34 INFO - 'MAIL': '/var/mail/cltbld', 20:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:34 INFO - 'MOZ_NO_REMOTE': '1', 20:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:34 INFO - 'NO_EM_RESTART': '1', 20:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:34 INFO - 'PWD': '/builds/slave/test', 20:00:34 INFO - 'SHELL': '/bin/bash', 20:00:34 INFO - 'SHLVL': '1', 20:00:34 INFO - 'TERM': 'linux', 20:00:34 INFO - 'TMOUT': '86400', 20:00:34 INFO - 'USER': 'cltbld', 20:00:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:34 INFO - '_': '/tools/buildbot/bin/python'} 20:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:34 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)) 20:00:34 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)) 20:00:34 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)) 20:00:34 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)) 20:00:34 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)) 20:00:34 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)) 20:00:34 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)) 20:00:34 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)) 20:00:34 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)) 20:00:34 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)) 20:00:34 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)) 20:00:34 INFO - Cleaning up... 20:00:34 INFO - Return code: 0 20:00:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:00:34 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')]} 20:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:34 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')]} 20:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:34 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 0x2789030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', '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 20:00:34 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 20:00:34 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 20:00:34 INFO - Using env: {'DISPLAY': ':0', 20:00:34 INFO - 'HOME': '/home/cltbld', 20:00:34 INFO - 'LANG': 'en_US.UTF-8', 20:00:34 INFO - 'LANGUAGE': 'en_US:en', 20:00:34 INFO - 'LOGNAME': 'cltbld', 20:00:34 INFO - 'MAIL': '/var/mail/cltbld', 20:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:34 INFO - 'MOZ_NO_REMOTE': '1', 20:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:34 INFO - 'NO_EM_RESTART': '1', 20:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:34 INFO - 'PWD': '/builds/slave/test', 20:00:34 INFO - 'SHELL': '/bin/bash', 20:00:34 INFO - 'SHLVL': '1', 20:00:34 INFO - 'TERM': 'linux', 20:00:34 INFO - 'TMOUT': '86400', 20:00:34 INFO - 'USER': 'cltbld', 20:00:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:34 INFO - '_': '/tools/buildbot/bin/python'} 20:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:00:35 INFO - Cleaning up... 20:00:35 INFO - Return code: 0 20:00:35 INFO - Running post-action listener: _resource_record_post_action 20:00:35 INFO - Running post-action listener: _start_resource_monitoring 20:00:35 INFO - Starting resource monitoring. 20:00:35 INFO - [mozharness: 2016-08-02 03:00:35.193020Z] Finished create-virtualenv step (success) 20:00:35 INFO - [mozharness: 2016-08-02 03:00:35.194066Z] Running install step. 20:00:35 INFO - Running pre-action listener: _resource_record_pre_action 20:00:35 INFO - Running main action method: install 20:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:35 INFO - Reading from file tmpfile_stdout 20:00:35 INFO - Detecting whether we're running mozinstall >=1.0... 20:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:00:35 INFO - Reading from file tmpfile_stdout 20:00:35 INFO - Output received: 20:00:35 INFO - Usage: mozinstall [options] installer 20:00:35 INFO - Options: 20:00:35 INFO - -h, --help show this help message and exit 20:00:35 INFO - -d DEST, --destination=DEST 20:00:35 INFO - Directory to install application into. [default: 20:00:35 INFO - "/builds/slave/test"] 20:00:35 INFO - --app=APP Application being installed. [default: firefox] 20:00:35 INFO - mkdir: /builds/slave/test/build/application 20:00:35 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'] 20:00:35 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 20:00:52 INFO - Reading from file tmpfile_stdout 20:00:52 INFO - Output received: 20:00:52 INFO - /builds/slave/test/build/application/firefox/firefox 20:00:52 INFO - Running post-action listener: _resource_record_post_action 20:00:52 INFO - [mozharness: 2016-08-02 03:00:52.348155Z] Finished install step (success) 20:00:52 INFO - [mozharness: 2016-08-02 03:00:52.348433Z] Running run-tests step. 20:00:52 INFO - Running pre-action listener: _resource_record_pre_action 20:00:52 INFO - Running main action method: run_tests 20:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:00:52 INFO - Python 2.7.3 20:00:52 INFO - Return code: 0 20:00:52 INFO - grabbing minidump binary from tooltool 20:00:52 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')]} 20:00:52 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 0x2a483b0>, '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 0x2a492b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a49740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:00:52 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 20:00:52 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 20:00:52 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 20:00:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:00:52 INFO - Return code: 0 20:00:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:00:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:00:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:00:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:00:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 20:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 20:00:52 INFO - Using env: {'DISPLAY': ':0', 20:00:52 INFO - 'HOME': '/home/cltbld', 20:00:52 INFO - 'LANG': 'en_US.UTF-8', 20:00:52 INFO - 'LANGUAGE': 'en_US:en', 20:00:52 INFO - 'LOGNAME': 'cltbld', 20:00:52 INFO - 'MAIL': '/var/mail/cltbld', 20:00:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:00:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:52 INFO - 'MOZ_NO_REMOTE': '1', 20:00:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:52 INFO - 'NO_EM_RESTART': '1', 20:00:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:52 INFO - 'PWD': '/builds/slave/test', 20:00:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:00:52 INFO - 'SHELL': '/bin/bash', 20:00:52 INFO - 'SHLVL': '1', 20:00:52 INFO - 'TERM': 'linux', 20:00:52 INFO - 'TMOUT': '86400', 20:00:52 INFO - 'USER': 'cltbld', 20:00:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526', 20:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:52 INFO - '_': '/tools/buildbot/bin/python'} 20:00:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 20:00:52 INFO - mozversion application_buildid: 20160801173002 20:00:52 INFO - mozversion application_changeset: bdfe8fd853b927c7d4fc3a45237f4cd35e49e86c 20:00:52 INFO - mozversion application_display_name: Nightly 20:00:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:00:52 INFO - mozversion application_name: Firefox 20:00:52 INFO - mozversion application_remotingname: firefox 20:00:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:00:52 INFO - mozversion application_vendor: Mozilla 20:00:52 INFO - mozversion application_version: 50.0a1 20:00:52 INFO - mozversion platform_buildid: 20160801173002 20:00:52 INFO - mozversion platform_changeset: bdfe8fd853b927c7d4fc3a45237f4cd35e49e86c 20:00:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:00:52 INFO - mozversion platform_version: 50.0a1 20:00:52 INFO - using testdate: 1470106852 20:00:52 INFO - actual date: 1470106852 20:00:52 INFO - starting webserver on 'localhost:52851' 20:00:52 INFO - SUITE-START | Running 2 tests 20:00:52 INFO - TEST-START | dromaeo_css 20:00:52 INFO - operating with platform_type : linux_ 20:00:52 INFO - Initialising browser for dromaeo_css test... 20:00:52 INFO - TEST-INFO | started process 3309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcrYweg/profile http://localhost:52851/getInfo.html) 20:00:58 INFO - PROCESS | 3309 | __metrics Screen width/height:1600/1200 20:00:58 INFO - PROCESS | 3309 | colorDepth:24 20:00:58 INFO - PROCESS | 3309 | Browser inner width/height: 1024/697 20:00:58 INFO - PROCESS | 3309 | __metrics 20:00:59 ERROR - PROCESS | 3309 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:01:00 INFO - TEST-INFO | 3309: exit 0 20:01:00 INFO - Browser initialized. 20:01:00 INFO - Running cycle 1/1 for dromaeo_css test... 20:01:00 INFO - TEST-INFO | started process 3428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcrYweg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:01:11 INFO - PROCESS | 3428 | RSS: Main: 163364864 20:01:11 INFO - PROCESS | 3428 | 20:02:01 INFO - PROCESS | 3428 | 1470106921520 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] 20:04:10 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52851/tests/dromaeo/cssquery-ext.html) 20:04:11 INFO - PROCESS | 3428 | RSS: Main: 168726528 20:04:11 INFO - PROCESS | 3428 | 20:07:13 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-ext.html (next: http://localhost:52851/tests/dromaeo/cssquery-jquery.html) 20:07:14 INFO - PROCESS | 3428 | RSS: Main: 166060032 20:07:14 INFO - PROCESS | 3428 | 20:10:16 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52851/tests/dromaeo/cssquery-mootools.html) 20:10:16 INFO - PROCESS | 3428 | RSS: Main: 169033728 20:10:16 INFO - PROCESS | 3428 | 20:13:18 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52851/tests/dromaeo/cssquery-prototype.html) 20:13:19 INFO - PROCESS | 3428 | RSS: Main: 163770368 20:13:19 INFO - PROCESS | 3428 | 20:16:21 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52851/tests/dromaeo/cssquery-yui.html) 20:16:22 INFO - PROCESS | 3428 | RSS: Main: 166092800 20:16:22 INFO - PROCESS | 3428 | 20:19:25 INFO - PROCESS | 3428 | Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-yui.html (next: http://localhost:52851/tests/dromaeo/cssquery-dojo.html) 20:19:25 INFO - PROCESS | 3428 | RSS: Main: 169918464 20:19:25 INFO - PROCESS | 3428 | 20:19:25 INFO - PROCESS | 3428 | __start_tp_report 20:19:25 INFO - PROCESS | 3428 | _x_x_mozilla_page_load 20:19:25 INFO - PROCESS | 3428 | _x_x_mozilla_page_load_details 20:19:25 INFO - PROCESS | 3428 | |i|pagename|runs| 20:19:25 INFO - PROCESS | 3428 | |0;dojo.html;3052.09963060897;3080.922976925578;3105.3168302973354;3106.409782141392;3113.159446949324;5248.0815857224925;5410.810621628239;5419.214213938972;5434.809781657643;5448.727563621813;5371.086915224411;5378.515933565978;5385.5960802939835;5411.404745477994;5450.209719590657;4862.2463518154655;4952.331435256248;4957.355543779304;5007.599392048645;5023.171176755849;4962.677425967318;5033.974830125844;5034.597232221432;5039.72281524516;5092.388913330406;4863.221884498481;4872.853814385574;4896.6817156885045;4946.307516947631;4979.053979743855;4858.489858564835;4867.902641947177;4871.902561948777;4934.851954441337;5000.224965130411;4857.611391088704;4887.486813884562;4904.435989861176;4906.215005599122;4931.950680493185;5253.684778913239;5339.6262261641705;5370.382406023318;5389.514943655051;5440.537554307849;5642.956053130184;5679.829605111853;5684.261046064026;5738.626989245686;5756.625819321773;5711.171880077407;5712.171735098387;5719.456651618131;5736.2542869427125;5736.7992120276;5295;5299.1786273127345;5363.195520671891;5373.167159090347;5418.8916221675345;5899.820035992819;5910.379410161871;5910.852228694231;5925.674087925206;5929.080992446177;5628.324601047901;5629.577781666309;5637;5646.124850648156;5647.802326918538;5612.494875461228;5714.942850571524;5757.050086735725;5784.4504772046585;5867.823965281048;5599.048161812501;5649.463300986482;5653.660780353192;5720.942790572124;5778.451047150514;5650.63270887391;5675.858103547444;5689.288838895138;5713.485786279255;5742.483176514133;4414.933775993362;4420.226460369487;4425.800838962255;4430.556944305608;4480.193565158303;3924.2151569685607;3974.682025437958;3983.5618082010956;3993.2612466693754;3995.6004399560393;5485.9725701371235;5511.090670039479;5539.473749993744;5557.305336832896;5586.636868603528;5765.509931655773;5783.334916484658;5795.88408231833;5805;5807.5644326675665;5533.363663178706;5543.1685247213245;5547.25112109868;5548.4451554845;5562.193481945095;4872.4640289568115;4964.354633897642;5011.5489605935645;5024.095662780662;5093.286939828427;5964.135200395918;5990.191324171268;6009.639421634716;6016.69916504173;6025.8192254232445;5774.480296773227;5813.418658134153;5832.12518122285;5845.970770146122;5848.766049358148;5733.59864809476;5912.881742365214;5971.373005834499;6000.549958753024;6098.054801505774;5699.316082070178;5716.228309178374;5720.685362305113;5722.62802917809;5728.054870946247;5758.740856661544;5762.625429347079;5769.22115514417;5771.769129234952;5815.883682326415;5531.391546929915;5580.748866300945;5648.2092507049865;5649.604527683023;5732.512736417451;5588.720563971704;5590.8043218487155;5652.463016013472;5652.63257888236;5653.943460565506;5591.412901645432;5596.552275817843;5597.468240517144;5599.216109744721;5604.747786349705;5480.369757477941;5529.4470552944385;5688.232088668143;5731.484166424875;5734.770609175753;5589.10574308125;5593.216949627137;5595.384507704231;5600.215969764317;5622.24099746529 20:19:25 INFO - PROCESS | 3428 | |1;ext.html;545.0246834183874;580.5065694159964;581.5289615411515;597.3697748874937;621.9595726277789;40177.397339039904;45346.093078138416;45376.3193552097;45485.31772023418;45526.317105243405;43997.34003989943;44461.77769111158;44600.553994460046;44739.881502962446;44852;8992.505412202327;9092.499912504809;9133.041030691782;9147.542622868863;9157.175854173123;9029.59366828491;9138;9144.634214631407;9146.542672866364;9157.587908544132;9156.587953542074;9167.770805729844;9171.954140229323;9189.1729744323;9224.769380765467;9120.133587309228;9139.131782480654;9148.176664100196;9188.081191880825;9199.448033118035;8961.551922403854;8985.505797181153;9022.954885225532;9035.186833185046;9041.141091596288;35582.28835423277;35953.64046359529;36042.63957360419;36133;36166.27667446636;3453.533772940646;3557.5908770491465;3579.337822502819;3585.2650206707563;3668.761530500509;31066.53400198999;33338.166545836306;33423.83288083568;33549.32901341984;33632.49551256733;4110;4254.851080212177;4314.3528470729325;4349.804258808361;4450.986751827542;372645;374305;374702;375068;377507;62226.37773622206;62359.37640623627;62507.37492625016;62610.68694656497;63012.36987630065;66907;67063;67192.6640366795;67217.32782672111;67451;15447.845521544865;15468.922655386876;15573.14347710864;15577.922110389376;15683.843161568466;11621.941890290494;11677.708057298636;11692;11707.121965852595;11748.941255293668;19177.520561985784;19338.839669619585;19432.96949619879;19479.417314815604;19540.533667103588;6950.721971121199;7205.171405288354;7253.27467253281;7397.963010184914;7466.85066298671;993.5380048277585;1028.681108856257;1102.1788767368203;1123.2474242257706;1175.8001139806254;33912.49131263033;34268.82865585656;34387.82806085954;34565.30869382598;34575.30849382998;1045.5608644369383;1143.2226086261255;1180.651707746217;1219.3110892345796;1223.4311045363947;17100.657986840193;17298.65402691939;17370.652586948192;17523;17557.473275801745;587947;589424;590754;591812;592452;62031.689841550506;62067.689661551405;62675.05987410193;62789.37210627835;62851.37148628547;1332.7401156774529;1355.66786137395;1362.284800479756;1368.6509939965244;1371.1704418826466;32961;35553;35761.64238357687;35961.28077438489;36044.45933311055;53044.73477632587;53381;53410.4658953421;53489.732551336994;53669.46330536801;427437;430857;431351;431384;431827;29374.853125734233;29596.260093497836;29939.904206705323;30070.69929300679;30156.396872061996;49284.50715492942;50091.24863126983;50333.74833125957;50684;51732.48267517277;41368.79315603403;41973.16053678971;42918.5708142927;43182.56817431786;44795.77602111969;41883.1623367537;42614.78692606517;43035.13929721325;43638.78180609077;44119.77940110279;36304;43487.56512434962;44986.55013449823;45287.54712452965;45451.54548454473;43137.56862431335;45083.54916450925;45712.31431528463;47177.528224717316;47648.761756190994;35947.28105437824;36233.79979327331;36726;37051.44422833714;37101.814490927376 20:19:25 INFO - PROCESS | 3428 | |2;jquery.html;345.75451429485065;371.88471573812114;371.9944200836987;380.1522604591762;390.0521732190777;18064.729029064576;18654.25382984679;19185.1366688499;19862.801371986276;20123;18682.43952681418;18868.150933208006;19101.904490477562;19187.904060479712;19496.122674479648;5563.388027316992;5678.403767604404;5745.195672605839;5748.109043098327;5749.885002299951;5613.691246981414;5614.045612245928;5655;5656;5656.490915817576;5512.944870551283;5579.2746942897365;5601.495865372116;5608.214849920994;5612.102063669814;5528.115501519757;5573.498385145316;5585.748641311151;5589.99999999998;5593.8321850344555;4780.426348838162;4948.257761335793;4992.900141997176;4993.7503124843615;4999.675021123651;22639.20762773295;23101.537969240522;23334.183303584294;23616;23784.76215237843;2329.580675478413;2645.550256456407;3102.8758849645988;3109.518024706174;3170.3342298117423;7334.4499162563025;14767.187804670739;14920;15201.557295841398;15433.074015559103;1954.4429837496386;1958.1090603775249;1982.4548249231432;2019.5960807838492;2030.187924830065;73422.99999999946;74298.62850685765;74498.62750686212;74576;74851.62574187094;9884.654037108667;9995.350302230332;10261.640842570474;10457.163426925828;10504.212184086224;10993.691324821717;13890.81928036108;13911.165330080228;13964;14035.368408421442;6836.487263455261;7110.431165506747;7322.926770732224;7333.1200255969625;7398.297161769623;7183.42532597391;7297.343239108506;7379.446541509408;7483.962580187064;7580.431467639949;3663.358912190356;3663.4871118043493;3674.926501469956;3715.8229713594487;3789.450529673182;1716.3265815829466;1748.3880641775277;1772.6986412309939;1784.4914199453094;1814.8566403166185;989.604158336671;995.4077323992213;1011.9342242754198;1016.5476363018386;1086.9565217391373;19704.70442943357;20196.69704954427;20291.18835246603;20349.898250508653;20383.687053685346;1033.0857191385678;1045.9529321180564;1046.3460337289193;1064.6646306413609;1070.240129508058;10616.575336986589;11217.831732524019;11309.151813614011;11407.372594507382;11420.88579114215;508760;544782;566753.1197941079;576840;588348;67306.66346668235;88542;90359;90757.54621226851;93028;405.1047185719534;425.9041715614024;428.4900967848251;429.2573847244285;429.5961795911833;9731.172850307803;10142;10288.074073333435;10320.12278956297;10422;40334;40449;40665.186696265315;40911.38632920449;42155.15689686251;56897.577560561316;57134;58286.708566456895;58493;58530.414695852494;7600.201978792147;7613.771586852404;7750.883736743841;7855.175206603224;8034.196580341919;10086.394816311045;11824.76350473003;12059.879401205875;12189.634310970685;12260.816087758869;11140.665780026613;11411.030062444454;11580;11676.649700508999;12149.271043737404;11402.714932126763;11432.599859005228;11690.240134391237;11705;12041.518339266331;11019;11722.58970936013;11913.285202887855;12076.698082548006;12131.332776697014;7649.388048956182;7743.109542402696;7956.2043795619975;8186.035351515712;8240.258376746122;10998.670039898816;11240.943795280971;11334.489947952527;11391.430428478378;11407.828882566602 20:19:25 INFO - PROCESS | 3428 | |3;mootools.html;1485.316754293025;1493.1190597547445;1595.7845690831741;1709.7178965470698;1729.8962062276257;7507.962460187705;8027.478213916106;8137.430379873411;8759.25546328562;8761.956190219047;8137.918620813805;8412.411131220817;8424.53665048422;8424.53665048422;8432.536210508435;2207.4922767763424;2236.2173239366175;2237.776222377757;2242.5290688955256;2242.5963326601204;2198.791114844087;2217.8225741940605;2260.7513173550897;2263.5586060718165;2273.4998300373973;2218.7781221877844;2230.119102954332;2238.462768935452;2243.3270018994317;2250.8987095580655;2159.233472117407;2174.1629472652985;2199.7910198531113;2202.0531171596285;2209.3924170853143;2178.803907648319;2182.9126834926583;2193.309107631091;2194.703714998471;2198.373463562893;8389.664413423456;8518.190771876662;8565.10066443027;8577.228049475514;8585.871211931826;4986.8753281168265;5061.924071138936;5076.187809950427;5111.7699703513435;5114.309568208281;3081.5377693345954;3186.4105140549073;3317.933641327184;3326.318104788537;3333.449980753197;1009.0716540782498;1016.044917777287;1023.5803320638577;1034.1468288661808;1059.1368035051407;11553.364564948924;11620.477078531487;11653.475593598308;11677.007454366389;11700.18098733089;4203.390508376329;4379.956200438019;4512.029913568598;4522.3668686383935;4537.909241815145;9363.859542106873;9369;9379.155875971059;9382.202512786353;9386.249100071978;4922.680025798311;4933.777979990909;4935.185694360391;4940.777665005084;4959.305697202394;4165.291900376943;4616.099860527165;4620.283856002325;4642.46611639659;4677.672562920631;3494.1264683829045;3540.7875527468436;3589.4974703541525;3611.8081033258964;3685.5761587417255;1057.296897563112;1080.0549519170725;1084.3030657021736;1089.1939964426267;1095.895889890459;881.3654168998311;1022.9693109206736;1031.2059714020163;1039.9480025998669;1040.5889673578895;5652.463016013472;5687.374388817227;5851.502622277069;5907.261592300963;5962.433568810956;394.4832269726667;402.5571870941999;403.62462909493865;406.91251380953236;408.1001391930786;4004.4994375703036;4168.228877657643;4201.054762678373;4252.55348188442;4269.444972153662;10287.074163325336;10575.20685948557;10708.08981236588;10709.410982395888;10732.087772539266;10572.894271057345;10587.311824731369;10592.57629694819;10602.946985265024;10607.787844243072;7555.508891922007;7884.487508311941;7936.682532698627;7937.603119843985;8056;5858.502027327725;6188.2883468399905;6210.875782484415;6221.129041934223;6280.309165991828;9498.667546635834;9567.282453815853;9619.903800961902;9653.1794797443;9671.177949874058;9472.810543789223;9695.563699633392;9889.50552472359;9955.800883982425;9991.400515969066;6926.515143939876;7209.675564599501;7340.376068034277;7442.404607631484;7578.583177925267;8114.878276825734;8146;8193.426460147732;8229.506229626242;8255.380846436421;7025.051618031501;7116.573005619679;7128.180259270251;7261.128664560287;7383.926160738539;7106.218315985341;7144.785656430316;7279.272072792678;7383.667734952048;7426.92573074284;6945.340192681687;6984.930150698428;7040.683169257498;7048;7055.753048643272;5316.202569614588;5352.35771707382;5378.542823860016;5384.19237114436;5524.585656075891;5307.787688492417;5314.4951229633125;5401.162819762943;5403;5445.40100588927 20:19:25 INFO - PROCESS | 3428 | |4;prototype.html;282.1155676952753;295.29130087789304;300.25237159472914;306.6902428547168;307.74149714240036;5336.9199462008;5471.206675032118;5529.447055294474;5606.21512988182;5612.943870561293;5431.809886653968;5466.130281602151;5471.945280547194;5500.22996780451;5505.504504594585;4236.131593023423;4239.494979282349;4266.701330906838;4291.527931927485;4299.957000430002;4123.422720819072;4169.916601667965;4246.851360202378;4312.654987600984;4316.525182229952;4156.210320039198;4170.35359519275;4183.62347388735;4188.72773269738;4212.831486740527;4181.289180839234;4193.161367726451;4199.202151591218;4206.579342065785;4212.789360531991;3464.8787292444645;3607.206414588786;3621.728370372233;3629.129009037812;3692.2615476904457;5249.950009997978;5263.789448422059;5320.6275560710765;5330.546903513167;5338.332708411449;4755.785989630475;4759.428868535798;4780.498047704976;4787.569118779326;4792.664513484057;5461.563074954034;5619.100943848965;5672.68800215988;5685.545156387479;5783.334916484574;3921.3529767588598;3938.7833669148185;3940.4089386591954;3948.74333168346;3951.1900060487533;6007.60950538218;6027.156198132265;6043.576949613484;6046.546509011798;6063.120847477091;3869.877735456686;4045;4066.877993660195;4088.2232375848494;4097.364908439196;4138.896527586834;4146.834126634961;4147.3986271991;4152.563980782034;4156.838444009099;4817.735024573612;4828.806847726122;4829.975850120727;4840.806367745321;4853.19922212838;5568.52667523257;5770.88458230833;5826.155207494974;5859.94140058594;5860.923015416855;1367.8426980897125;1394.776835706282;1406.4303956897472;1417.2842714429148;1417.7589809732165;844.7803571071443;873.921347078766;900.4642237868458;902.255639097747;902.801383695586;4903.877403064952;4906.835091366049;4920.729359885169;4928.310036594879;4933.901321973541;5129.3075434816565;5171.663841850268;5179.280877539247;5184.507471790249;5221.503957124067;4994.9500504994485;5030.446650868402;5031.9181376004335;5051.595872330205;5222.947770522246;3115.968840311568;3156.8579413926427;3162.256869635634;3171.4925611901986;3202.3915456063273;6174.25908890927;6185.8453538661;6197.140857742659;6201.441870231611;6212.875742485125;5887.61730487517;5959.493443057302;5989.550783691154;6027.21646185993;6032.3967603239325;6131.662758548234;6136.079588061826;6151.600145990406;6156.614761678587;6167.506599472032;5815.854603634943;5940.495057920125;5959.135925290895;5969.970150149222;5983.4914032306;5898.528117750656;5928.614640048383;5953.8742160366155;5960.807838432417;5979.611325263844;5927.614705044159;6055.969720151371;6250.749970001331;6250.843728906813;6277.591956522811;3985.880423587297;4018.296798060386;4029.6171863672903;4049.57479464652;4049.635532802062;5733.799317023884;5911.645301281937;5940.485176280021;5965.254343207099;5965.34381218057;5592.972035139798;5753.683547404933;5769.1634712967225;5771.769129234784;5776.393478684846;5675.616241178797;5704.828855134353;5771.374024818781;5790.449907258803;5815.139155470209;5548.750306236309;5705.7147142643535;5711.8000869969355;5718.599698021098;5736.04593634287;5760.740766665426;5779.243491730409;5825;5835.94164058354;5854.882902342015;5486.615936884539;5630.88738225225;5695.715214239354;5711.628744131618;5739.253896993364 20:19:25 INFO - PROCESS | 3428 | |5;yui.html;744.1702501710595;760.3005235183631;769.4649174896083;775.3990657240635;879.4986857491233;14649.267536623167;14939.626509337271;15164.393424263044;15238.695226095471;15249.161296128708;14592.41630334788;14800.185989770558;15431;15510.224488775573;15639.218039098056;808.7897146741846;832.8417600655886;840.017179899516;840.3361344537808;841.2092632925031;793.1275596843484;825.4923222218353;831.2061980808344;835.9205875441824;839.6851180807197;861.1689719420758;863.3007264116086;863.6200071968314;863.874738162966;863.9265662418702;857.7855536115972;858.8282343531288;858.8797568340406;859.6389516403094;859.6991053131417;622.4802290087782;627.3569591169042;627.6014730646073;630.9432151106377;631.2677294338545;13425.932870335684;13454.461821527128;13467.326633668376;13535.864641353657;13581.932090339584;15247.695046099127;15271.236438178157;15329.693406131815;15509.146996915166;15621.843781562266;12571.116516904118;12802.423890924838;12864.163829351155;12904.54834080812;13010.284434356106;3763.172102137525;3806.809659517013;3857.1321452673205;3895.2988462076814;3974.1852920151587;80721;82994;83441.16558834455;83489;84233.57883210544;11077;11139.164562657834;11254.98705116527;11351.148663850245;11643.476043578059;19286.4214073578;19335.12991915367;19362.225510979402;19364.806351936582;19489.707654385194;8163.795905102301;8181.67273309061;8260.380471464665;8389.244967952913;8421;4604.677672562955;4696.7416792076765;4743.430788305356;4813.638977076734;5045;3466.9133271667906;3575.249197668467;3582.6059133495296;3582.6238244984424;3583.498310236569;585.1369230385233;588.7615515716142;594.3284088979512;599.8950183717832;601.1823919469518;624.7782037376757;676.9289224631441;686.4679873098389;777.4790890103644;788.7751990682742;9820.803583928282;10298.3820970742;10685.358878467317;10891.891081089247;10931.672049838518;610.703808652803;636.3133349142349;775.5075527040257;796.1998191817303;797.8391440454126;4777.856664300077;4894.902101957941;4924.064427758714;4947.82682606107;4952.900941981212;94773;99374.5031274839;111816;127375;130550;98473;100864.49567752115;100908.49545752224;102050;103179;78091;79893;82329.58835205785;89968;90886;9908.752281193028;9945.701628951143;10218.744531386776;10376.273660843668;10636.627718029831;52772.472275276756;52924;54175.72912135414;54717.452825471235;54872.725636371564;76550.6172469134;77511;77794.6110269445;79441.60279198567;80964;12481.438335274754;12495.750084998432;12657.87342126567;12697.36513174319;13052.34738263064;15292.158931258888;15447.691046178788;15654.530364089096;15872.365105395655;16036.679266414372;14199.929000354932;14492.594295308907;14658.120512769268;14691.412343506567;15163.09021458716;14397.568072957829;14470.855291446951;14912.925435372754;14917;15265.23673816327;13741.931290343484;13798.379072941943;14345.282735863373;14874.479393221185;14963.32665030098;11272.267302625303;11402.885971140182;11500.309981401142;11614.941925290319;11817.172797904064;9913.801723965336;10118.443485608363;11442.37066961325;11770.882291176978;11986.580469683868 20:19:25 INFO - PROCESS | 3428 | __end_tp_report 20:19:25 INFO - PROCESS | 3428 | __start_cc_report 20:19:25 INFO - PROCESS | 3428 | _x_x_mozilla_cycle_collect,374 20:19:25 INFO - PROCESS | 3428 | __end_cc_report 20:19:25 INFO - PROCESS | 3428 | __startTimestamp1470107965653__endTimestamp 20:19:25 INFO - PROCESS | 3428 | 20:19:25 INFO - PROCESS | 3428 | ------- Summary: start ------- 20:19:25 INFO - PROCESS | 3428 | Number of tests: 6 20:19:25 INFO - PROCESS | 3428 | 20:19:25 INFO - PROCESS | 3428 | [#0] dojo.html Cycles:165 Average:5364.34 Median:5591.41 stddev:601.67 (10.8%) stddev-sans-first:575.52 20:19:25 INFO - PROCESS | 3428 | Values: 3052.1 3080.9 3105.3 3106.4 3113.2 5248.1 5410.8 5419.2 5434.8 5448.7 5371.1 5378.5 5385.6 5411.4 5450.2 4862.2 4952.3 4957.4 5007.6 5023.2 4962.7 5034.0 5034.6 5039.7 5092.4 4863.2 4872.9 4896.7 4946.3 4979.1 4858.5 4867.9 4871.9 4934.9 5000.2 4857.6 4887.5 4904.4 4906.2 4932.0 5253.7 5339.6 5370.4 5389.5 5440.5 5643.0 5679.8 5684.3 5738.6 5756.6 5711.2 5712.2 5719.5 5736.3 5736.8 5295.0 5299.2 5363.2 5373.2 5418.9 5899.8 5910.4 5910.9 5925.7 5929.1 5628.3 5629.6 5637.0 5646.1 5647.8 5612.5 5714.9 5757.1 5784.5 5867.8 5599.0 5649.5 5653.7 5720.9 5778.5 5650.6 5675.9 5689.3 5713.5 5742.5 4414.9 4420.2 4425.8 4430.6 4480.2 3924.2 3974.7 3983.6 3993.3 3995.6 5486.0 5511.1 5539.5 5557.3 5586.6 5765.5 5783.3 5795.9 5805.0 5807.6 5533.4 5543.2 5547.3 5548.4 5562.2 4872.5 4964.4 5011.5 5024.1 5093.3 5964.1 5990.2 6009.6 6016.7 6025.8 5774.5 5813.4 5832.1 5846.0 5848.8 5733.6 5912.9 5971.4 6000.5 6098.1 5699.3 5716.2 5720.7 5722.6 5728.1 5758.7 5762.6 5769.2 5771.8 5815.9 5531.4 5580.7 5648.2 5649.6 5732.5 5588.7 5590.8 5652.5 5652.6 5653.9 5591.4 5596.6 5597.5 5599.2 5604.7 5480.4 5529.4 5688.2 5731.5 5734.8 5589.1 5593.2 5595.4 5600.2 5622.2 20:19:25 INFO - PROCESS | 3428 | 20:19:25 INFO - PROCESS | 3428 | [#1] ext.html Cycles:180 Average:63597.03 Median:237504.78 stddev:125838.36 (53.0%) stddev-sans-first:126102.33 20:19:25 INFO - PROCESS | 3428 | Values: 545.0 580.5 581.5 597.4 622.0 40177.4 45346.1 45376.3 45485.3 45526.3 43997.3 44461.8 44600.6 44739.9 44852.0 8992.5 9092.5 9133.0 9147.5 9157.2 9029.6 9138.0 9144.6 9146.5 9157.6 9156.6 9167.8 9172.0 9189.2 9224.8 9120.1 9139.1 9148.2 9188.1 9199.4 8961.6 8985.5 9023.0 9035.2 9041.1 35582.3 35953.6 36042.6 36133.0 36166.3 3453.5 3557.6 3579.3 3585.3 3668.8 31066.5 33338.2 33423.8 33549.3 33632.5 4110.0 4254.9 4314.4 4349.8 4451.0 372645.0 374305.0 374702.0 375068.0 377507.0 62226.4 62359.4 62507.4 62610.7 63012.4 66907.0 67063.0 67192.7 67217.3 67451.0 15447.8 15468.9 15573.1 15577.9 15683.8 11621.9 11677.7 11692.0 11707.1 11748.9 19177.5 19338.8 19433.0 19479.4 19540.5 6950.7 7205.2 7253.3 7398.0 7466.9 993.5 1028.7 1102.2 1123.2 1175.8 33912.5 34268.8 34387.8 34565.3 34575.3 1045.6 1143.2 1180.7 1219.3 1223.4 17100.7 17298.7 17370.7 17523.0 17557.5 587947.0 589424.0 590754.0 591812.0 592452.0 62031.7 62067.7 62675.1 62789.4 62851.4 1332.7 1355.7 1362.3 1368.7 1371.2 32961.0 35553.0 35761.6 35961.3 36044.5 53044.7 53381.0 53410.5 53489.7 53669.5 427437.0 430857.0 431351.0 431384.0 431827.0 29374.9 29596.3 29939.9 30070.7 30156.4 49284.5 50091.2 50333.7 50684.0 51732.5 41368.8 41973.2 42918.6 43182.6 44795.8 41883.2 42614.8 43035.1 43638.8 44119.8 36304.0 43487.6 44986.6 45287.5 45451.5 43137.6 45083.5 45712.3 47177.5 47648.8 35947.3 36233.8 36726.0 37051.4 37101.8 20:19:25 INFO - PROCESS | 3428 | 20:19:25 INFO - PROCESS | 3428 | [#2] jquery.html Cycles:180 Average:30148.04 Median:3663.42 stddev:91531.57 (2498.5%) stddev-sans-first:91760.98 20:19:25 INFO - PROCESS | 3428 | Values: 345.8 371.9 372.0 380.2 390.1 18064.7 18654.3 19185.1 19862.8 20123.0 18682.4 18868.2 19101.9 19187.9 19496.1 5563.4 5678.4 5745.2 5748.1 5749.9 5613.7 5614.0 5655.0 5656.0 5656.5 5512.9 5579.3 5601.5 5608.2 5612.1 5528.1 5573.5 5585.7 5590.0 5593.8 4780.4 4948.3 4992.9 4993.8 4999.7 22639.2 23101.5 23334.2 23616.0 23784.8 2329.6 2645.6 3102.9 3109.5 3170.3 7334.4 14767.2 14920.0 15201.6 15433.1 1954.4 1958.1 1982.5 2019.6 2030.2 73423.0 74298.6 74498.6 74576.0 74851.6 9884.7 9995.4 10261.6 10457.2 10504.2 10993.7 13890.8 13911.2 13964.0 14035.4 6836.5 7110.4 7322.9 7333.1 7398.3 7183.4 7297.3 7379.4 7484.0 7580.4 3663.4 3663.5 3674.9 3715.8 3789.5 1716.3 1748.4 1772.7 1784.5 1814.9 989.6 995.4 1011.9 1016.5 1087.0 19704.7 20196.7 20291.2 20349.9 20383.7 1033.1 1046.0 1046.3 1064.7 1070.2 10616.6 11217.8 11309.2 11407.4 11420.9 508760.0 544782.0 566753.1 576840.0 588348.0 67306.7 88542.0 90359.0 90757.5 93028.0 405.1 425.9 428.5 429.3 429.6 9731.2 10142.0 10288.1 10320.1 10422.0 40334.0 40449.0 40665.2 40911.4 42155.2 56897.6 57134.0 58286.7 58493.0 58530.4 7600.2 7613.8 7750.9 7855.2 8034.2 10086.4 11824.8 12059.9 12189.6 12260.8 11140.7 11411.0 11580.0 11676.6 12149.3 11402.7 11432.6 11690.2 11705.0 12041.5 11019.0 11722.6 11913.3 12076.7 12131.3 7649.4 7743.1 7956.2 8186.0 8240.3 10998.7 11240.9 11334.5 11391.4 11407.8 20:19:25 INFO - PROCESS | 3428 | 20:19:25 INFO - PROCESS | 3428 | [#3] mootools.html Cycles:180 Average:5569.76 Median:4934.48 stddev:3162.31 (64.1%) stddev-sans-first:3156.29 20:19:25 INFO - PROCESS | 3428 | Values: 1485.3 1493.1 1595.8 1709.7 1729.9 7508.0 8027.5 8137.4 8759.3 8762.0 8137.9 8412.4 8424.5 8424.5 8432.5 2207.5 2236.2 2237.8 2242.5 2242.6 2198.8 2217.8 2260.8 2263.6 2273.5 2218.8 2230.1 2238.5 2243.3 2250.9 2159.2 2174.2 2199.8 2202.1 2209.4 2178.8 2182.9 2193.3 2194.7 2198.4 8389.7 8518.2 8565.1 8577.2 8585.9 4986.9 5061.9 5076.2 5111.8 5114.3 3081.5 3186.4 3317.9 3326.3 3333.4 1009.1 1016.0 1023.6 1034.1 1059.1 11553.4 11620.5 11653.5 11677.0 11700.2 4203.4 4380.0 4512.0 4522.4 4537.9 9363.9 9369.0 9379.2 9382.2 9386.2 4922.7 4933.8 4935.2 4940.8 4959.3 4165.3 4616.1 4620.3 4642.5 4677.7 3494.1 3540.8 3589.5 3611.8 3685.6 1057.3 1080.1 1084.3 1089.2 1095.9 881.4 1023.0 1031.2 1039.9 1040.6 5652.5 5687.4 5851.5 5907.3 5962.4 394.5 402.6 403.6 406.9 408.1 4004.5 4168.2 4201.1 4252.6 4269.4 10287.1 10575.2 10708.1 10709.4 10732.1 10572.9 10587.3 10592.6 10602.9 10607.8 7555.5 7884.5 7936.7 7937.6 8056.0 5858.5 6188.3 6210.9 6221.1 6280.3 9498.7 9567.3 9619.9 9653.2 9671.2 9472.8 9695.6 9889.5 9955.8 9991.4 6926.5 7209.7 7340.4 7442.4 7578.6 8114.9 8146.0 8193.4 8229.5 8255.4 7025.1 7116.6 7128.2 7261.1 7383.9 7106.2 7144.8 7279.3 7383.7 7426.9 6945.3 6984.9 7040.7 7048.0 7055.8 5316.2 5352.4 5378.5 5384.2 5524.6 5307.8 5314.5 5401.2 5403.0 5445.4 20:19:25 INFO - PROCESS | 3428 | 20:19:25 INFO - PROCESS | 3428 | [#4] prototype.html Cycles:180 Average:4771.83 Median:5385.07 stddev:1445.45 (26.8%) stddev-sans-first:1409.68 20:19:25 INFO - PROCESS | 3428 | Values: 282.1 295.3 300.3 306.7 307.7 5336.9 5471.2 5529.4 5606.2 5612.9 5431.8 5466.1 5471.9 5500.2 5505.5 4236.1 4239.5 4266.7 4291.5 4300.0 4123.4 4169.9 4246.9 4312.7 4316.5 4156.2 4170.4 4183.6 4188.7 4212.8 4181.3 4193.2 4199.2 4206.6 4212.8 3464.9 3607.2 3621.7 3629.1 3692.3 5250.0 5263.8 5320.6 5330.5 5338.3 4755.8 4759.4 4780.5 4787.6 4792.7 5461.6 5619.1 5672.7 5685.5 5783.3 3921.4 3938.8 3940.4 3948.7 3951.2 6007.6 6027.2 6043.6 6046.5 6063.1 3869.9 4045.0 4066.9 4088.2 4097.4 4138.9 4146.8 4147.4 4152.6 4156.8 4817.7 4828.8 4830.0 4840.8 4853.2 5568.5 5770.9 5826.2 5859.9 5860.9 1367.8 1394.8 1406.4 1417.3 1417.8 844.8 873.9 900.5 902.3 902.8 4903.9 4906.8 4920.7 4928.3 4933.9 5129.3 5171.7 5179.3 5184.5 5221.5 4995.0 5030.4 5031.9 5051.6 5222.9 3116.0 3156.9 3162.3 3171.5 3202.4 6174.3 6185.8 6197.1 6201.4 6212.9 5887.6 5959.5 5989.6 6027.2 6032.4 6131.7 6136.1 6151.6 6156.6 6167.5 5815.9 5940.5 5959.1 5970.0 5983.5 5898.5 5928.6 5953.9 5960.8 5979.6 5927.6 6056.0 6250.7 6250.8 6277.6 3985.9 4018.3 4029.6 4049.6 4049.6 5733.8 5911.6 5940.5 5965.3 5965.3 5593.0 5753.7 5769.2 5771.8 5776.4 5675.6 5704.8 5771.4 5790.4 5815.1 5548.8 5705.7 5711.8 5718.6 5736.0 5760.7 5779.2 5825.0 5835.9 5854.9 5486.6 5630.9 5695.7 5711.6 5739.3 20:19:25 INFO - PROCESS | 3428 | 20:19:25 INFO - PROCESS | 3428 | [#5] yui.html Cycles:180 Average:21213.32 Median:3876.22 stddev:30465.84 (786.0%) stddev-sans-first:30512.53 20:19:25 INFO - PROCESS | 3428 | Values: 744.2 760.3 769.5 775.4 879.5 14649.3 14939.6 15164.4 15238.7 15249.2 14592.4 14800.2 15431.0 15510.2 15639.2 808.8 832.8 840.0 840.3 841.2 793.1 825.5 831.2 835.9 839.7 861.2 863.3 863.6 863.9 863.9 857.8 858.8 858.9 859.6 859.7 622.5 627.4 627.6 630.9 631.3 13425.9 13454.5 13467.3 13535.9 13581.9 15247.7 15271.2 15329.7 15509.1 15621.8 12571.1 12802.4 12864.2 12904.5 13010.3 3763.2 3806.8 3857.1 3895.3 3974.2 80721.0 82994.0 83441.2 83489.0 84233.6 11077.0 11139.2 11255.0 11351.1 11643.5 19286.4 19335.1 19362.2 19364.8 19489.7 8163.8 8181.7 8260.4 8389.2 8421.0 4604.7 4696.7 4743.4 4813.6 5045.0 3466.9 3575.2 3582.6 3582.6 3583.5 585.1 588.8 594.3 599.9 601.2 624.8 676.9 686.5 777.5 788.8 9820.8 10298.4 10685.4 10891.9 10931.7 610.7 636.3 775.5 796.2 797.8 4777.9 4894.9 4924.1 4947.8 4952.9 94773.0 99374.5 111816.0 127375.0 130550.0 98473.0 100864.5 100908.5 102050.0 103179.0 78091.0 79893.0 82329.6 89968.0 90886.0 9908.8 9945.7 10218.7 10376.3 10636.6 52772.5 52924.0 54175.7 54717.5 54872.7 76550.6 77511.0 77794.6 79441.6 80964.0 12481.4 12495.8 12657.9 12697.4 13052.3 15292.2 15447.7 15654.5 15872.4 16036.7 14199.9 14492.6 14658.1 14691.4 15163.1 14397.6 14470.9 14912.9 14917.0 15265.2 13741.9 13798.4 14345.3 14874.5 14963.3 11272.3 11402.9 11500.3 11614.9 11817.2 9913.8 10118.4 11442.4 11770.9 11986.6 20:19:25 INFO - PROCESS | 3428 | -------- Summary: end -------- 20:19:25 INFO - PROCESS | 3428 | 20:19:26 INFO - TEST-INFO | 3428: exit 0 20:19:26 INFO - TEST-OK | dromaeo_css | took 1113650ms 20:19:26 INFO - TEST-START | kraken 20:19:26 INFO - operating with platform_type : linux_ 20:19:26 INFO - Initialising browser for kraken test... 20:19:26 INFO - TEST-INFO | started process 3676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHq0Wjc/profile http://localhost:52851/getInfo.html) 20:19:30 INFO - PROCESS | 3676 | __metrics Screen width/height:1600/1200 20:19:30 INFO - PROCESS | 3676 | colorDepth:24 20:19:30 INFO - PROCESS | 3676 | Browser inner width/height: 1024/697 20:19:30 INFO - PROCESS | 3676 | __metrics 20:19:31 ERROR - PROCESS | 3676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:19:32 INFO - TEST-INFO | 3676: exit 0 20:19:32 INFO - Browser initialized. 20:19:32 INFO - Running cycle 1/1 for kraken test... 20:19:32 INFO - TEST-INFO | started process 3795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHq0Wjc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:44 INFO - PROCESS | 3795 | RSS: Main: 163336192 20:19:44 INFO - PROCESS | 3795 | 20:19:46 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52851/tests/kraken/driver.html?testName=audio-beat-detection) 20:19:47 INFO - PROCESS | 3795 | RSS: Main: 168873984 20:19:47 INFO - PROCESS | 3795 | 20:19:50 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52851/tests/kraken/driver.html?testName=audio-dft) 20:19:51 INFO - PROCESS | 3795 | RSS: Main: 167268352 20:19:51 INFO - PROCESS | 3795 | 20:19:53 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52851/tests/kraken/driver.html?testName=audio-fft) 20:19:54 INFO - PROCESS | 3795 | RSS: Main: 164401152 20:19:54 INFO - PROCESS | 3795 | 20:19:56 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52851/tests/kraken/driver.html?testName=audio-oscillator) 20:19:57 INFO - PROCESS | 3795 | RSS: Main: 165171200 20:19:57 INFO - PROCESS | 3795 | 20:19:59 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:20:00 INFO - PROCESS | 3795 | RSS: Main: 165470208 20:20:00 INFO - PROCESS | 3795 | 20:20:03 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52851/tests/kraken/driver.html?testName=imaging-darkroom) 20:20:03 INFO - PROCESS | 3795 | RSS: Main: 165277696 20:20:03 INFO - PROCESS | 3795 | 20:20:07 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52851/tests/kraken/driver.html?testName=imaging-desaturate) 20:20:07 INFO - PROCESS | 3795 | RSS: Main: 163676160 20:20:07 INFO - PROCESS | 3795 | 20:20:10 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52851/tests/kraken/driver.html?testName=json-parse-financial) 20:20:11 INFO - PROCESS | 3795 | RSS: Main: 164839424 20:20:11 INFO - PROCESS | 3795 | 20:20:13 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:20:13 INFO - PROCESS | 3795 | RSS: Main: 165056512 20:20:13 INFO - PROCESS | 3795 | 20:20:15 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:20:16 INFO - PROCESS | 3795 | RSS: Main: 164470784 20:20:16 INFO - PROCESS | 3795 | 20:20:18 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:20:18 INFO - PROCESS | 3795 | RSS: Main: 164855808 20:20:18 INFO - PROCESS | 3795 | 20:20:21 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:20:22 INFO - PROCESS | 3795 | RSS: Main: 165801984 20:20:22 INFO - PROCESS | 3795 | 20:20:24 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:20:25 INFO - PROCESS | 3795 | RSS: Main: 165552128 20:20:25 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52851/tests/kraken/driver.html?testName=ai-astar) 20:20:27 INFO - PROCESS | 3795 | RSS: Main: 166395904 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | __start_tp_report 20:20:27 INFO - PROCESS | 3795 | _x_x_mozilla_page_load 20:20:27 INFO - PROCESS | 3795 | _x_x_mozilla_page_load_details 20:20:27 INFO - PROCESS | 3795 | |i|pagename|runs| 20:20:27 INFO - PROCESS | 3795 | |0;ai-astar;100;112;107;111;111;111;115;110;111;111 20:20:27 INFO - PROCESS | 3795 | |1;audio-beat-detection;153;117;149;175;120;147;152;121;181;126 20:20:27 INFO - PROCESS | 3795 | |2;audio-dft;162;163;161;162;164;173;164;162;165;162 20:20:27 INFO - PROCESS | 3795 | |3;audio-fft;74;76;75;184;76;74;76;74;162;76 20:20:27 INFO - PROCESS | 3795 | |4;audio-oscillator;85;84;146;85;84;84;142;84;84;140 20:20:27 INFO - PROCESS | 3795 | |5;imaging-gaussian-blur;117;118;117;117;120;118;118;118;118;119 20:20:27 INFO - PROCESS | 3795 | |6;imaging-darkroom;147;149;146;149;149;148;146;147;147;148 20:20:27 INFO - PROCESS | 3795 | |7;imaging-desaturate;96;96;96;95;95;96;96;97;95;95 20:20:27 INFO - PROCESS | 3795 | |8;json-parse-financial;54;56;55;53;55;54;57;55;55;55 20:20:27 INFO - PROCESS | 3795 | |9;json-stringify-tinderbox;61;61;61;62;65;62;61;61;62;62 20:20:27 INFO - PROCESS | 3795 | |10;stanford-crypto-aes;76;83;78;77;77;83;76;82;77;78 20:20:27 INFO - PROCESS | 3795 | |11;stanford-crypto-ccm;129;122;121;125;123;129;129;124;172;126 20:20:27 INFO - PROCESS | 3795 | |12;stanford-crypto-pbkdf2;161;159;164;154;164;158;155;157;158;162 20:20:27 INFO - PROCESS | 3795 | |13;stanford-crypto-sha256-iterative;65;65;63;65;65;63;63;64;63;69 20:20:27 INFO - PROCESS | 3795 | __end_tp_report 20:20:27 INFO - PROCESS | 3795 | __start_cc_report 20:20:27 INFO - PROCESS | 3795 | _x_x_mozilla_cycle_collect,874 20:20:27 INFO - PROCESS | 3795 | __end_cc_report 20:20:27 INFO - PROCESS | 3795 | __startTimestamp1470108027369__endTimestamp 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | ------- Summary: start ------- 20:20:27 INFO - PROCESS | 3795 | Number of tests: 14 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.98 (3.6%) stddev-sans-first:2.06 20:20:27 INFO - PROCESS | 3795 | Values: 100.0 112.0 107.0 111.0 111.0 111.0 115.0 110.0 111.0 111.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:150.50 stddev:22.77 (15.1%) stddev-sans-first:23.92 20:20:27 INFO - PROCESS | 3795 | Values: 153.0 117.0 149.0 175.0 120.0 147.0 152.0 121.0 181.0 126.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:3.46 (2.1%) stddev-sans-first:3.61 20:20:27 INFO - PROCESS | 3795 | Values: 162.0 163.0 161.0 162.0 164.0 173.0 164.0 162.0 165.0 162.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.50 stddev:41.60 (55.1%) stddev-sans-first:43.45 20:20:27 INFO - PROCESS | 3795 | Values: 74.0 76.0 75.0 184.0 76.0 74.0 76.0 74.0 162.0 76.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:84.00 stddev:28.24 (33.6%) stddev-sans-first:29.29 20:20:27 INFO - PROCESS | 3795 | Values: 85.0 84.0 146.0 85.0 84.0 84.0 142.0 84.0 84.0 140.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 20:20:27 INFO - PROCESS | 3795 | Values: 117.0 118.0 117.0 117.0 120.0 118.0 118.0 118.0 118.0 119.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.17 (0.8%) stddev-sans-first:1.22 20:20:27 INFO - PROCESS | 3795 | Values: 147.0 149.0 146.0 149.0 149.0 148.0 146.0 147.0 147.0 148.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 20:20:27 INFO - PROCESS | 3795 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 97.0 95.0 95.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.10 (2.0%) stddev-sans-first:1.12 20:20:27 INFO - PROCESS | 3795 | Values: 54.0 56.0 55.0 53.0 55.0 54.0 57.0 55.0 55.0 55.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:1.23 (2.0%) stddev-sans-first:1.27 20:20:27 INFO - PROCESS | 3795 | Values: 61.0 61.0 61.0 62.0 65.0 62.0 61.0 61.0 62.0 62.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:2.83 (3.6%) stddev-sans-first:2.83 20:20:27 INFO - PROCESS | 3795 | Values: 76.0 83.0 78.0 77.0 77.0 83.0 76.0 82.0 77.0 78.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:127.50 stddev:15.05 (11.8%) stddev-sans-first:15.96 20:20:27 INFO - PROCESS | 3795 | Values: 129.0 122.0 121.0 125.0 123.0 129.0 129.0 124.0 172.0 126.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:160.00 stddev:3.49 (2.2%) stddev-sans-first:3.64 20:20:27 INFO - PROCESS | 3795 | Values: 161.0 159.0 164.0 154.0 164.0 158.0 155.0 157.0 158.0 162.0 20:20:27 INFO - PROCESS | 3795 | 20:20:27 INFO - PROCESS | 3795 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.84 (2.8%) stddev-sans-first:1.94 20:20:27 INFO - PROCESS | 3795 | Values: 65.0 65.0 63.0 65.0 65.0 63.0 63.0 64.0 63.0 69.0 20:20:27 INFO - PROCESS | 3795 | -------- Summary: end -------- 20:20:27 INFO - PROCESS | 3795 | 20:20:28 INFO - TEST-INFO | 3795: exit 0 20:20:28 INFO - TEST-OK | kraken | took 61985ms 20:20:28 INFO - SUITE-END | took 1175s 20:20:28 INFO - Completed test suite (00:19:35) 20:20:28 INFO - javascript benchmark 20:20:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7202.469020467447, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.09963060897, 3080.922976925578, 3105.3168302973354, 3106.409782141392, 3113.159446949324, 5248.0815857224925, 5410.810621628239, 5419.214213938972, 5434.809781657643, 5448.727563621813, 5371.086915224411, 5378.515933565978, 5385.5960802939835, 5411.404745477994, 5450.209719590657, 4862.2463518154655, 4952.331435256248, 4957.355543779304, 5007.599392048645, 5023.171176755849, 4962.677425967318, 5033.974830125844, 5034.597232221432, 5039.72281524516, 5092.388913330406, 4863.221884498481, 4872.853814385574, 4896.6817156885045, 4946.307516947631, 4979.053979743855, 4858.489858564835, 4867.902641947177, 4871.902561948777, 4934.851954441337, 5000.224965130411, 4857.611391088704, 4887.486813884562, 4904.435989861176, 4906.215005599122, 4931.950680493185, 5253.684778913239, 5339.6262261641705, 5370.382406023318, 5389.514943655051, 5440.537554307849, 5642.956053130184, 5679.829605111853, 5684.261046064026, 5738.626989245686, 5756.625819321773, 5711.171880077407, 5712.171735098387, 5719.456651618131, 5736.2542869427125, 5736.7992120276, 5295.0, 5299.1786273127345, 5363.195520671891, 5373.167159090347, 5418.8916221675345, 5899.820035992819, 5910.379410161871, 5910.852228694231, 5925.674087925206, 5929.080992446177, 5628.324601047901, 5629.577781666309, 5637.0, 5646.124850648156, 5647.802326918538, 5612.494875461228, 5714.942850571524, 5757.050086735725, 5784.4504772046585, 5867.823965281048, 5599.048161812501, 5649.463300986482, 5653.660780353192, 5720.942790572124, 5778.451047150514, 5650.63270887391, 5675.858103547444, 5689.288838895138, 5713.485786279255, 5742.483176514133, 4414.933775993362, 4420.226460369487, 4425.800838962255, 4430.556944305608, 4480.193565158303, 3924.2151569685607, 3974.682025437958, 3983.5618082010956, 3993.2612466693754, 3995.6004399560393, 5485.9725701371235, 5511.090670039479, 5539.473749993744, 5557.305336832896, 5586.636868603528, 5765.509931655773, 5783.334916484658, 5795.88408231833, 5805.0, 5807.5644326675665, 5533.363663178706, 5543.1685247213245, 5547.25112109868, 5548.4451554845, 5562.193481945095, 4872.4640289568115, 4964.354633897642, 5011.5489605935645, 5024.095662780662, 5093.286939828427, 5964.135200395918, 5990.191324171268, 6009.639421634716, 6016.69916504173, 6025.8192254232445, 5774.480296773227, 5813.418658134153, 5832.12518122285, 5845.970770146122, 5848.766049358148, 5733.59864809476, 5912.881742365214, 5971.373005834499, 6000.549958753024, 6098.054801505774, 5699.316082070178, 5716.228309178374, 5720.685362305113, 5722.62802917809, 5728.054870946247, 5758.740856661544, 5762.625429347079, 5769.22115514417, 5771.769129234952, 5815.883682326415, 5531.391546929915, 5580.748866300945, 5648.2092507049865, 5649.604527683023, 5732.512736417451, 5588.720563971704, 5590.8043218487155, 5652.463016013472, 5652.63257888236, 5653.943460565506, 5591.412901645432, 5596.552275817843, 5597.468240517144, 5599.216109744721, 5604.747786349705, 5480.369757477941, 5529.4470552944385, 5688.232088668143, 5731.484166424875, 5734.770609175753, 5589.10574308125, 5593.216949627137, 5595.384507704231, 5600.215969764317, 5622.24099746529], "value": 5323.807545920426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.0246834183874, 580.5065694159964, 581.5289615411515, 597.3697748874937, 621.9595726277789, 40177.397339039904, 45346.093078138416, 45376.3193552097, 45485.31772023418, 45526.317105243405, 43997.34003989943, 44461.77769111158, 44600.553994460046, 44739.881502962446, 44852.0, 8992.505412202327, 9092.499912504809, 9133.041030691782, 9147.542622868863, 9157.175854173123, 9029.59366828491, 9138.0, 9144.634214631407, 9146.542672866364, 9157.587908544132, 9156.587953542074, 9167.770805729844, 9171.954140229323, 9189.1729744323, 9224.769380765467, 9120.133587309228, 9139.131782480654, 9148.176664100196, 9188.081191880825, 9199.448033118035, 8961.551922403854, 8985.505797181153, 9022.954885225532, 9035.186833185046, 9041.141091596288, 35582.28835423277, 35953.64046359529, 36042.63957360419, 36133.0, 36166.27667446636, 3453.533772940646, 3557.5908770491465, 3579.337822502819, 3585.2650206707563, 3668.761530500509, 31066.53400198999, 33338.166545836306, 33423.83288083568, 33549.32901341984, 33632.49551256733, 4110.0, 4254.851080212177, 4314.3528470729325, 4349.804258808361, 4450.986751827542, 372645.0, 374305.0, 374702.0, 375068.0, 377507.0, 62226.37773622206, 62359.37640623627, 62507.37492625016, 62610.68694656497, 63012.36987630065, 66907.0, 67063.0, 67192.6640366795, 67217.32782672111, 67451.0, 15447.845521544865, 15468.922655386876, 15573.14347710864, 15577.922110389376, 15683.843161568466, 11621.941890290494, 11677.708057298636, 11692.0, 11707.121965852595, 11748.941255293668, 19177.520561985784, 19338.839669619585, 19432.96949619879, 19479.417314815604, 19540.533667103588, 6950.721971121199, 7205.171405288354, 7253.27467253281, 7397.963010184914, 7466.85066298671, 993.5380048277585, 1028.681108856257, 1102.1788767368203, 1123.2474242257706, 1175.8001139806254, 33912.49131263033, 34268.82865585656, 34387.82806085954, 34565.30869382598, 34575.30849382998, 1045.5608644369383, 1143.2226086261255, 1180.651707746217, 1219.3110892345796, 1223.4311045363947, 17100.657986840193, 17298.65402691939, 17370.652586948192, 17523.0, 17557.473275801745, 587947.0, 589424.0, 590754.0, 591812.0, 592452.0, 62031.689841550506, 62067.689661551405, 62675.05987410193, 62789.37210627835, 62851.37148628547, 1332.7401156774529, 1355.66786137395, 1362.284800479756, 1368.6509939965244, 1371.1704418826466, 32961.0, 35553.0, 35761.64238357687, 35961.28077438489, 36044.45933311055, 53044.73477632587, 53381.0, 53410.4658953421, 53489.732551336994, 53669.46330536801, 427437.0, 430857.0, 431351.0, 431384.0, 431827.0, 29374.853125734233, 29596.260093497836, 29939.904206705323, 30070.69929300679, 30156.396872061996, 49284.50715492942, 50091.24863126983, 50333.74833125957, 50684.0, 51732.48267517277, 41368.79315603403, 41973.16053678971, 42918.5708142927, 43182.56817431786, 44795.77602111969, 41883.1623367537, 42614.78692606517, 43035.13929721325, 43638.78180609077, 44119.77940110279, 36304.0, 43487.56512434962, 44986.55013449823, 45287.54712452965, 45451.54548454473, 43137.56862431335, 45083.54916450925, 45712.31431528463, 47177.528224717316, 47648.761756190994, 35947.28105437824, 36233.79979327331, 36726.0, 37051.44422833714, 37101.814490927376], "value": 20887.587998087012, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.75451429485065, 371.88471573812114, 371.9944200836987, 380.1522604591762, 390.0521732190777, 18064.729029064576, 18654.25382984679, 19185.1366688499, 19862.801371986276, 20123.0, 18682.43952681418, 18868.150933208006, 19101.904490477562, 19187.904060479712, 19496.122674479648, 5563.388027316992, 5678.403767604404, 5745.195672605839, 5748.109043098327, 5749.885002299951, 5613.691246981414, 5614.045612245928, 5655.0, 5656.0, 5656.490915817576, 5512.944870551283, 5579.2746942897365, 5601.495865372116, 5608.214849920994, 5612.102063669814, 5528.115501519757, 5573.498385145316, 5585.748641311151, 5589.99999999998, 5593.8321850344555, 4780.426348838162, 4948.257761335793, 4992.900141997176, 4993.7503124843615, 4999.675021123651, 22639.20762773295, 23101.537969240522, 23334.183303584294, 23616.0, 23784.76215237843, 2329.580675478413, 2645.550256456407, 3102.8758849645988, 3109.518024706174, 3170.3342298117423, 7334.4499162563025, 14767.187804670739, 14920.0, 15201.557295841398, 15433.074015559103, 1954.4429837496386, 1958.1090603775249, 1982.4548249231432, 2019.5960807838492, 2030.187924830065, 73422.99999999946, 74298.62850685765, 74498.62750686212, 74576.0, 74851.62574187094, 9884.654037108667, 9995.350302230332, 10261.640842570474, 10457.163426925828, 10504.212184086224, 10993.691324821717, 13890.81928036108, 13911.165330080228, 13964.0, 14035.368408421442, 6836.487263455261, 7110.431165506747, 7322.926770732224, 7333.1200255969625, 7398.297161769623, 7183.42532597391, 7297.343239108506, 7379.446541509408, 7483.962580187064, 7580.431467639949, 3663.358912190356, 3663.4871118043493, 3674.926501469956, 3715.8229713594487, 3789.450529673182, 1716.3265815829466, 1748.3880641775277, 1772.6986412309939, 1784.4914199453094, 1814.8566403166185, 989.604158336671, 995.4077323992213, 1011.9342242754198, 1016.5476363018386, 1086.9565217391373, 19704.70442943357, 20196.69704954427, 20291.18835246603, 20349.898250508653, 20383.687053685346, 1033.0857191385678, 1045.9529321180564, 1046.3460337289193, 1064.6646306413609, 1070.240129508058, 10616.575336986589, 11217.831732524019, 11309.151813614011, 11407.372594507382, 11420.88579114215, 508760.0, 544782.0, 566753.1197941079, 576840.0, 588348.0, 67306.66346668235, 88542.0, 90359.0, 90757.54621226851, 93028.0, 405.1047185719534, 425.9041715614024, 428.4900967848251, 429.2573847244285, 429.5961795911833, 9731.172850307803, 10142.0, 10288.074073333435, 10320.12278956297, 10422.0, 40334.0, 40449.0, 40665.186696265315, 40911.38632920449, 42155.15689686251, 56897.577560561316, 57134.0, 58286.708566456895, 58493.0, 58530.414695852494, 7600.201978792147, 7613.771586852404, 7750.883736743841, 7855.175206603224, 8034.196580341919, 10086.394816311045, 11824.76350473003, 12059.879401205875, 12189.634310970685, 12260.816087758869, 11140.665780026613, 11411.030062444454, 11580.0, 11676.649700508999, 12149.271043737404, 11402.714932126763, 11432.599859005228, 11690.240134391237, 11705.0, 12041.518339266331, 11019.0, 11722.58970936013, 11913.285202887855, 12076.698082548006, 12131.332776697014, 7649.388048956182, 7743.109542402696, 7956.2043795619975, 8186.035351515712, 8240.258376746122, 10998.670039898816, 11240.943795280971, 11334.489947952527, 11391.430428478378, 11407.828882566602], "value": 8698.587861577382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.316754293025, 1493.1190597547445, 1595.7845690831741, 1709.7178965470698, 1729.8962062276257, 7507.962460187705, 8027.478213916106, 8137.430379873411, 8759.25546328562, 8761.956190219047, 8137.918620813805, 8412.411131220817, 8424.53665048422, 8424.53665048422, 8432.536210508435, 2207.4922767763424, 2236.2173239366175, 2237.776222377757, 2242.5290688955256, 2242.5963326601204, 2198.791114844087, 2217.8225741940605, 2260.7513173550897, 2263.5586060718165, 2273.4998300373973, 2218.7781221877844, 2230.119102954332, 2238.462768935452, 2243.3270018994317, 2250.8987095580655, 2159.233472117407, 2174.1629472652985, 2199.7910198531113, 2202.0531171596285, 2209.3924170853143, 2178.803907648319, 2182.9126834926583, 2193.309107631091, 2194.703714998471, 2198.373463562893, 8389.664413423456, 8518.190771876662, 8565.10066443027, 8577.228049475514, 8585.871211931826, 4986.8753281168265, 5061.924071138936, 5076.187809950427, 5111.7699703513435, 5114.309568208281, 3081.5377693345954, 3186.4105140549073, 3317.933641327184, 3326.318104788537, 3333.449980753197, 1009.0716540782498, 1016.044917777287, 1023.5803320638577, 1034.1468288661808, 1059.1368035051407, 11553.364564948924, 11620.477078531487, 11653.475593598308, 11677.007454366389, 11700.18098733089, 4203.390508376329, 4379.956200438019, 4512.029913568598, 4522.3668686383935, 4537.909241815145, 9363.859542106873, 9369.0, 9379.155875971059, 9382.202512786353, 9386.249100071978, 4922.680025798311, 4933.777979990909, 4935.185694360391, 4940.777665005084, 4959.305697202394, 4165.291900376943, 4616.099860527165, 4620.283856002325, 4642.46611639659, 4677.672562920631, 3494.1264683829045, 3540.7875527468436, 3589.4974703541525, 3611.8081033258964, 3685.5761587417255, 1057.296897563112, 1080.0549519170725, 1084.3030657021736, 1089.1939964426267, 1095.895889890459, 881.3654168998311, 1022.9693109206736, 1031.2059714020163, 1039.9480025998669, 1040.5889673578895, 5652.463016013472, 5687.374388817227, 5851.502622277069, 5907.261592300963, 5962.433568810956, 394.4832269726667, 402.5571870941999, 403.62462909493865, 406.91251380953236, 408.1001391930786, 4004.4994375703036, 4168.228877657643, 4201.054762678373, 4252.55348188442, 4269.444972153662, 10287.074163325336, 10575.20685948557, 10708.08981236588, 10709.410982395888, 10732.087772539266, 10572.894271057345, 10587.311824731369, 10592.57629694819, 10602.946985265024, 10607.787844243072, 7555.508891922007, 7884.487508311941, 7936.682532698627, 7937.603119843985, 8056.0, 5858.502027327725, 6188.2883468399905, 6210.875782484415, 6221.129041934223, 6280.309165991828, 9498.667546635834, 9567.282453815853, 9619.903800961902, 9653.1794797443, 9671.177949874058, 9472.810543789223, 9695.563699633392, 9889.50552472359, 9955.800883982425, 9991.400515969066, 6926.515143939876, 7209.675564599501, 7340.376068034277, 7442.404607631484, 7578.583177925267, 8114.878276825734, 8146.0, 8193.426460147732, 8229.506229626242, 8255.380846436421, 7025.051618031501, 7116.573005619679, 7128.180259270251, 7261.128664560287, 7383.926160738539, 7106.218315985341, 7144.785656430316, 7279.272072792678, 7383.667734952048, 7426.92573074284, 6945.340192681687, 6984.930150698428, 7040.683169257498, 7048.0, 7055.753048643272, 5316.202569614588, 5352.35771707382, 5378.542823860016, 5384.19237114436, 5524.585656075891, 5307.787688492417, 5314.4951229633125, 5401.162819762943, 5403.0, 5445.40100588927], "value": 4371.424908876149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.1155676952753, 295.29130087789304, 300.25237159472914, 306.6902428547168, 307.74149714240036, 5336.9199462008, 5471.206675032118, 5529.447055294474, 5606.21512988182, 5612.943870561293, 5431.809886653968, 5466.130281602151, 5471.945280547194, 5500.22996780451, 5505.504504594585, 4236.131593023423, 4239.494979282349, 4266.701330906838, 4291.527931927485, 4299.957000430002, 4123.422720819072, 4169.916601667965, 4246.851360202378, 4312.654987600984, 4316.525182229952, 4156.210320039198, 4170.35359519275, 4183.62347388735, 4188.72773269738, 4212.831486740527, 4181.289180839234, 4193.161367726451, 4199.202151591218, 4206.579342065785, 4212.789360531991, 3464.8787292444645, 3607.206414588786, 3621.728370372233, 3629.129009037812, 3692.2615476904457, 5249.950009997978, 5263.789448422059, 5320.6275560710765, 5330.546903513167, 5338.332708411449, 4755.785989630475, 4759.428868535798, 4780.498047704976, 4787.569118779326, 4792.664513484057, 5461.563074954034, 5619.100943848965, 5672.68800215988, 5685.545156387479, 5783.334916484574, 3921.3529767588598, 3938.7833669148185, 3940.4089386591954, 3948.74333168346, 3951.1900060487533, 6007.60950538218, 6027.156198132265, 6043.576949613484, 6046.546509011798, 6063.120847477091, 3869.877735456686, 4045.0, 4066.877993660195, 4088.2232375848494, 4097.364908439196, 4138.896527586834, 4146.834126634961, 4147.3986271991, 4152.563980782034, 4156.838444009099, 4817.735024573612, 4828.806847726122, 4829.975850120727, 4840.806367745321, 4853.19922212838, 5568.52667523257, 5770.88458230833, 5826.155207494974, 5859.94140058594, 5860.923015416855, 1367.8426980897125, 1394.776835706282, 1406.4303956897472, 1417.2842714429148, 1417.7589809732165, 844.7803571071443, 873.921347078766, 900.4642237868458, 902.255639097747, 902.801383695586, 4903.877403064952, 4906.835091366049, 4920.729359885169, 4928.310036594879, 4933.901321973541, 5129.3075434816565, 5171.663841850268, 5179.280877539247, 5184.507471790249, 5221.503957124067, 4994.9500504994485, 5030.446650868402, 5031.9181376004335, 5051.595872330205, 5222.947770522246, 3115.968840311568, 3156.8579413926427, 3162.256869635634, 3171.4925611901986, 3202.3915456063273, 6174.25908890927, 6185.8453538661, 6197.140857742659, 6201.441870231611, 6212.875742485125, 5887.61730487517, 5959.493443057302, 5989.550783691154, 6027.21646185993, 6032.3967603239325, 6131.662758548234, 6136.079588061826, 6151.600145990406, 6156.614761678587, 6167.506599472032, 5815.854603634943, 5940.495057920125, 5959.135925290895, 5969.970150149222, 5983.4914032306, 5898.528117750656, 5928.614640048383, 5953.8742160366155, 5960.807838432417, 5979.611325263844, 5927.614705044159, 6055.969720151371, 6250.749970001331, 6250.843728906813, 6277.591956522811, 3985.880423587297, 4018.296798060386, 4029.6171863672903, 4049.57479464652, 4049.635532802062, 5733.799317023884, 5911.645301281937, 5940.485176280021, 5965.254343207099, 5965.34381218057, 5592.972035139798, 5753.683547404933, 5769.1634712967225, 5771.769129234784, 5776.393478684846, 5675.616241178797, 5704.828855134353, 5771.374024818781, 5790.449907258803, 5815.139155470209, 5548.750306236309, 5705.7147142643535, 5711.8000869969355, 5718.599698021098, 5736.04593634287, 5760.740766665426, 5779.243491730409, 5825.0, 5835.94164058354, 5854.882902342015, 5486.615936884539, 5630.88738225225, 5695.715214239354, 5711.628744131618, 5739.253896993364], "value": 4292.63042688049, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.1702501710595, 760.3005235183631, 769.4649174896083, 775.3990657240635, 879.4986857491233, 14649.267536623167, 14939.626509337271, 15164.393424263044, 15238.695226095471, 15249.161296128708, 14592.41630334788, 14800.185989770558, 15431.0, 15510.224488775573, 15639.218039098056, 808.7897146741846, 832.8417600655886, 840.017179899516, 840.3361344537808, 841.2092632925031, 793.1275596843484, 825.4923222218353, 831.2061980808344, 835.9205875441824, 839.6851180807197, 861.1689719420758, 863.3007264116086, 863.6200071968314, 863.874738162966, 863.9265662418702, 857.7855536115972, 858.8282343531288, 858.8797568340406, 859.6389516403094, 859.6991053131417, 622.4802290087782, 627.3569591169042, 627.6014730646073, 630.9432151106377, 631.2677294338545, 13425.932870335684, 13454.461821527128, 13467.326633668376, 13535.864641353657, 13581.932090339584, 15247.695046099127, 15271.236438178157, 15329.693406131815, 15509.146996915166, 15621.843781562266, 12571.116516904118, 12802.423890924838, 12864.163829351155, 12904.54834080812, 13010.284434356106, 3763.172102137525, 3806.809659517013, 3857.1321452673205, 3895.2988462076814, 3974.1852920151587, 80721.0, 82994.0, 83441.16558834455, 83489.0, 84233.57883210544, 11077.0, 11139.164562657834, 11254.98705116527, 11351.148663850245, 11643.476043578059, 19286.4214073578, 19335.12991915367, 19362.225510979402, 19364.806351936582, 19489.707654385194, 8163.795905102301, 8181.67273309061, 8260.380471464665, 8389.244967952913, 8421.0, 4604.677672562955, 4696.7416792076765, 4743.430788305356, 4813.638977076734, 5045.0, 3466.9133271667906, 3575.249197668467, 3582.6059133495296, 3582.6238244984424, 3583.498310236569, 585.1369230385233, 588.7615515716142, 594.3284088979512, 599.8950183717832, 601.1823919469518, 624.7782037376757, 676.9289224631441, 686.4679873098389, 777.4790890103644, 788.7751990682742, 9820.803583928282, 10298.3820970742, 10685.358878467317, 10891.891081089247, 10931.672049838518, 610.703808652803, 636.3133349142349, 775.5075527040257, 796.1998191817303, 797.8391440454126, 4777.856664300077, 4894.902101957941, 4924.064427758714, 4947.82682606107, 4952.900941981212, 94773.0, 99374.5031274839, 111816.0, 127375.0, 130550.0, 98473.0, 100864.49567752115, 100908.49545752224, 102050.0, 103179.0, 78091.0, 79893.0, 82329.58835205785, 89968.0, 90886.0, 9908.752281193028, 9945.701628951143, 10218.744531386776, 10376.273660843668, 10636.627718029831, 52772.472275276756, 52924.0, 54175.72912135414, 54717.452825471235, 54872.725636371564, 76550.6172469134, 77511.0, 77794.6110269445, 79441.60279198567, 80964.0, 12481.438335274754, 12495.750084998432, 12657.87342126567, 12697.36513174319, 13052.34738263064, 15292.158931258888, 15447.691046178788, 15654.530364089096, 15872.365105395655, 16036.679266414372, 14199.929000354932, 14492.594295308907, 14658.120512769268, 14691.412343506567, 15163.09021458716, 14397.568072957829, 14470.855291446951, 14912.925435372754, 14917.0, 15265.23673816327, 13741.931290343484, 13798.379072941943, 14345.282735863373, 14874.479393221185, 14963.32665030098, 11272.267302625303, 11402.885971140182, 11500.309981401142, 11614.941925290319, 11817.172797904064, 9913.801723965336, 10118.443485608363, 11442.37066961325, 11770.882291176978, 11986.580469683868], "value": 7690.153136150748, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 107.0, 111.0, 111.0, 111.0, 115.0, 110.0, 111.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 117.0, 149.0, 175.0, 120.0, 147.0, 152.0, 121.0, 181.0, 126.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 164.0, 173.0, 164.0, 162.0, 165.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 184.0, 76.0, 74.0, 76.0, 74.0, 162.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 146.0, 85.0, 84.0, 84.0, 142.0, 84.0, 84.0, 140.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 120.0, 118.0, 118.0, 118.0, 118.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 146.0, 149.0, 149.0, 148.0, 146.0, 147.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 53.0, 55.0, 54.0, 57.0, 55.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 65.0, 62.0, 61.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 78.0, 77.0, 77.0, 83.0, 76.0, 82.0, 77.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 122.0, 121.0, 125.0, 123.0, 129.0, 129.0, 124.0, 172.0, 126.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 164.0, 154.0, 164.0, 158.0, 155.0, 157.0, 158.0, 162.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 65.0, 65.0, 63.0, 63.0, 64.0, 63.0, 69.0], "value": 64.5, "unit": "score"}]}]} 20:20:28 INFO - Return code: 0 20:20:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:20:28 ERROR - # TBPL SUCCESS # 20:20:28 INFO - Running post-action listener: _resource_record_post_action 20:20:28 INFO - [mozharness: 2016-08-02 03:20:28.694767Z] Finished run-tests step (success) 20:20:28 INFO - Running post-run listener: _resource_record_post_run 20:20:28 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7819264; Write bytes: 332460032; Read time: 1300; Write time: 219316 20:20:28 INFO - TinderboxPrint: CPU usage
13.3% 20:20:28 INFO - TinderboxPrint: I/O read bytes / time
7,819,264 / 1,300 20:20:28 INFO - TinderboxPrint: I/O write bytes / time
332,460,032 / 219,316 20:20:28 INFO - TinderboxPrint: CPU idle
8,247.5 (86.6%) 20:20:28 INFO - TinderboxPrint: CPU user
1,214.4 (12.8%) 20:20:28 INFO - TinderboxPrint: Swap in / out
0 / 0 20:20:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 92160000; Read time: 0; Write time: 64540 20:20:28 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5443584; Write bytes: 240300032; Read time: 892; Write time: 154776 20:20:29 INFO - Running post-run listener: _upload_blobber_files 20:20:29 INFO - Blob upload gear active. 20:20:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:20:29 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 20:20:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:20:29 INFO - (blobuploader) - INFO - Open directory for files ... 20:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:36 INFO - (blobuploader) - INFO - Done attempting. 20:20:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:20:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:20:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:37 INFO - (blobuploader) - INFO - Done attempting. 20:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:38 INFO - (blobuploader) - INFO - Done attempting. 20:20:38 INFO - (blobuploader) - INFO - Iteration through files over. 20:20:38 INFO - Return code: 0 20:20:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:20:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:20:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61111171d666aef2227103c6167c66d70dd891d0e77118f372023a3b82554bc09c3ada7b2b2e3a4c5086e00c3bcbc480cba5aea1c55d917dcd1d05eed982f1d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c5736354d0282e88a727c4e4fd1777de0c14763cf52be0bd025b92f92beb89cab686e4c0ac99f4cf329729c31657abed7eedf40166b4b7a1d30f31e5e2418b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adccbaa767b96577fc8ec38aae4abce35fbe83449236025c9519dc2353b1338de52741b921aea369b9987ce5bbce5d4e5f624d57527289a27981c685968eccf7"} 20:20:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:20:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:20:38 INFO - Contents: 20:20:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61111171d666aef2227103c6167c66d70dd891d0e77118f372023a3b82554bc09c3ada7b2b2e3a4c5086e00c3bcbc480cba5aea1c55d917dcd1d05eed982f1d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c5736354d0282e88a727c4e4fd1777de0c14763cf52be0bd025b92f92beb89cab686e4c0ac99f4cf329729c31657abed7eedf40166b4b7a1d30f31e5e2418b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adccbaa767b96577fc8ec38aae4abce35fbe83449236025c9519dc2353b1338de52741b921aea369b9987ce5bbce5d4e5f624d57527289a27981c685968eccf7"} 20:20:38 INFO - Running post-run listener: copy_logs_to_upload_dir 20:20:38 INFO - Copying logs to upload dir... 20:20:38 INFO - mkdir: /builds/slave/test/build/upload/logs 20:20:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.301772 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-01 20:20:38.069987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 20:20:38.075758) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61111171d666aef2227103c6167c66d70dd891d0e77118f372023a3b82554bc09c3ada7b2b2e3a4c5086e00c3bcbc480cba5aea1c55d917dcd1d05eed982f1d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c5736354d0282e88a727c4e4fd1777de0c14763cf52be0bd025b92f92beb89cab686e4c0ac99f4cf329729c31657abed7eedf40166b4b7a1d30f31e5e2418b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adccbaa767b96577fc8ec38aae4abce35fbe83449236025c9519dc2353b1338de52741b921aea369b9987ce5bbce5d4e5f624d57527289a27981c685968eccf7"} build_url:https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011108 build_url: 'https://queue.taskcluster.net/v1/task/ZgdP1wQhSM6yCSwLjB94KA/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/sha512/61111171d666aef2227103c6167c66d70dd891d0e77118f372023a3b82554bc09c3ada7b2b2e3a4c5086e00c3bcbc480cba5aea1c55d917dcd1d05eed982f1d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c5736354d0282e88a727c4e4fd1777de0c14763cf52be0bd025b92f92beb89cab686e4c0ac99f4cf329729c31657abed7eedf40166b4b7a1d30f31e5e2418b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adccbaa767b96577fc8ec38aae4abce35fbe83449236025c9519dc2353b1338de52741b921aea369b9987ce5bbce5d4e5f624d57527289a27981c685968eccf7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 20:20:38.100197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 20:20:38.100514) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470105126.427286-307184526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 20:20:38.182097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 20:20:38.182417) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 20:20:38.182700) ========= ========= Total master_lag: 0.17 =========