builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1464663677.81 results: success (0) buildid: 20160530173007 builduid: 823a5a77dae04dda9129639a90408260 revision: 3a87296fe4145138c2ce15512bb31f76fe869cb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:17.807375) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:17.807841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:17.808189) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:17.887260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:17.887582) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 20:01:18-- 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% 26.7M=0s 2016-05-30 20:01:18 (26.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137362 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.061629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.061950) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.117211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.117664) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3a87296fe4145138c2ce15512bb31f76fe869cb4 --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 3a87296fe4145138c2ce15512bb31f76fe869cb4 --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=e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 20:01:18,548 truncating revision to first 12 chars 2016-05-30 20:01:18,548 Setting DEBUG logging. 2016-05-30 20:01:18,548 attempt 1/10 2016-05-30 20:01:18,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3a87296fe414?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 20:01:18,880 unpacking tar archive at: fx-team-3a87296fe414/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.801237) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.804622) ========= script_repo_revision: 3a87296fe4145138c2ce15512bb31f76fe869cb4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.805120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.805415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 20:01:18.815867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 20:01:18.816268) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:01:19 INFO - MultiFileLogger online at 20160530 20:01:19 in /builds/slave/test 20:01:19 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 20:01:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:01:19 INFO - {'append_to_log': False, 20:01:19 INFO - 'base_work_dir': '/builds/slave/test', 20:01:19 INFO - 'blob_upload_branch': 'Fx-Team', 20:01:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:01:19 INFO - 'branch': 'Fx-Team', 20:01:19 INFO - 'buildbot_json_path': 'buildprops.json', 20:01:19 INFO - 'config_files': ('talos/linux_config.py',), 20:01:19 INFO - 'default_actions': ('clobber', 20:01:19 INFO - 'read-buildbot-config', 20:01:19 INFO - 'download-and-extract', 20:01:19 INFO - 'populate-webroot', 20:01:19 INFO - 'create-virtualenv', 20:01:19 INFO - 'install', 20:01:19 INFO - 'run-tests'), 20:01:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:01:19 INFO - 'download_minidump_stackwalk': True, 20:01:19 INFO - 'download_symbols': 'ondemand', 20:01:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:01:19 INFO - 'tooltool.py': '/tools/tooltool.py', 20:01:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:01:19 INFO - '/tools/misc-python/virtualenv.py')}, 20:01:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:01:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:01:19 INFO - 'installer_path': 'installer.exe', 20:01:19 INFO - 'log_level': 'info', 20:01:19 INFO - 'log_name': 'talos', 20:01:19 INFO - 'log_to_console': True, 20:01:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:01:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:01:19 INFO - 'opt_config_files': (), 20:01:19 INFO - 'pip_index': False, 20:01:19 INFO - 'sps_profile': False, 20:01:19 INFO - 'sps_profile_interval': 0, 20:01:19 INFO - 'suite': 'dromaeojs-e10s', 20:01:19 INFO - 'system_bits': '32', 20:01:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:01:19 INFO - 'title': 'talos-linux64-ix-006', 20:01:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:01:19 INFO - 'use_talos_json': True, 20:01:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:01:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:01:19 INFO - 'work_dir': 'build'} 20:01:19 INFO - ##### 20:01:19 INFO - ##### Running clobber step. 20:01:19 INFO - ##### 20:01:19 INFO - Running pre-action listener: _resource_record_pre_action 20:01:19 INFO - Running main action method: clobber 20:01:19 INFO - rmtree: /builds/slave/test/build 20:01:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:01:19 INFO - Running post-action listener: _resource_record_post_action 20:01:19 INFO - ##### 20:01:19 INFO - ##### Finished clobber step (success) 20:01:19 INFO - ##### 20:01:19 INFO - ##### 20:01:19 INFO - ##### Running read-buildbot-config step. 20:01:19 INFO - ##### 20:01:19 INFO - Running pre-action listener: _resource_record_pre_action 20:01:19 INFO - Running main action method: read_buildbot_config 20:01:19 INFO - Using buildbot properties: 20:01:19 INFO - { 20:01:19 INFO - "project": "", 20:01:19 INFO - "product": "firefox", 20:01:19 INFO - "script_repo_revision": "production", 20:01:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:01:19 INFO - "repository": "", 20:01:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:01:19 INFO - "buildid": "20160530173007", 20:01:19 INFO - "pgo_build": "True", 20:01:19 INFO - "basedir": "/builds/slave/test", 20:01:19 INFO - "buildnumber": 395, 20:01:19 INFO - "slavename": "talos-linux64-ix-006", 20:01:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:01:19 INFO - "platform": "ubuntu64_hw", 20:01:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:01:19 INFO - "branch": "fx-team", 20:01:19 INFO - "repo_path": "integration/fx-team", 20:01:19 INFO - "revision": "3a87296fe4145138c2ce15512bb31f76fe869cb4", 20:01:19 INFO - "stage_platform": "linux64-pgo", 20:01:19 INFO - "builduid": "823a5a77dae04dda9129639a90408260", 20:01:19 INFO - "slavebuilddir": "test" 20:01:19 INFO - } 20:01:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:01:19 INFO - Running post-action listener: _resource_record_post_action 20:01:19 INFO - ##### 20:01:19 INFO - ##### Finished read-buildbot-config step (success) 20:01:19 INFO - ##### 20:01:19 INFO - ##### 20:01:19 INFO - ##### Running download-and-extract step. 20:01:19 INFO - ##### 20:01:19 INFO - Running pre-action listener: _resource_record_pre_action 20:01:19 INFO - Running main action method: download_and_extract 20:01:19 INFO - mkdir: /builds/slave/test/build/tests 20:01: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:01:19 INFO - https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:01:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:01:20 INFO - Downloaded 1361 bytes. 20:01:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:01:20 INFO - Using the following test package requirements: 20:01:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:01:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:01:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:20 INFO - u'jsshell-linux-x86_64.zip'], 20:01:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:01:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:01:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:01:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:01:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:01:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:01:20 INFO - https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:01:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:01:22 INFO - Downloaded 24410718 bytes. 20:01:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:01:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:01:23 INFO - Return code: 0 20:01:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:01: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:01:23 INFO - https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:01:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:01:27 INFO - Downloaded 24410718 bytes. 20:01:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:01:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:01:28 INFO - Return code: 0 20:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:01:28 INFO - https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:01:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:01:30 INFO - Downloaded 10834055 bytes. 20:01:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:01:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:01:30 INFO - Return code: 0 20:01: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:01:30 INFO - https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:01:32 INFO - Downloaded 58945452 bytes. 20:01:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:32 INFO - mkdir: /builds/slave/test/properties 20:01:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:01:32 INFO - Writing to file /builds/slave/test/properties/build_url 20:01:32 INFO - Contents: 20:01:32 INFO - build_url:https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:01:33 INFO - Running post-action listener: _resource_record_post_action 20:01:33 INFO - Running post-action listener: set_extra_try_arguments 20:01:33 INFO - ##### 20:01:33 INFO - ##### Finished download-and-extract step (success) 20:01:33 INFO - ##### 20:01:33 INFO - ##### 20:01:33 INFO - ##### Running populate-webroot step. 20:01:33 INFO - ##### 20:01:33 INFO - Running pre-action listener: _resource_record_pre_action 20:01:33 INFO - Running main action method: populate_webroot 20:01:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:01:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:01:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:01:33 INFO - '--tppagecycles', 20:01:33 INFO - '7'], 20:01:33 INFO - 'tests': ['tsvgm']}}, 20:01:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:01:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:01:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:01:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:01:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:01:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:01:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'talos_options': ['--disable-e10s'], 20:01:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'talos_options': ['--disable-e10s'], 20:01:33 INFO - 'tests': ['damp', 'tps']}, 20:01:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'tests': ['damp', 'tps']}, 20:01:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:01:33 INFO - 'tests': ['dromaeo_dom']}, 20:01:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:01:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:01:33 INFO - 'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore', 20:01:33 INFO - 'tabpaint']}, 20:01:33 INFO - 'other-e10s': {'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore', 20:01:33 INFO - 'tabpaint']}, 20:01:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore', 20:01:33 INFO - 'tabpaint']}, 20:01:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore', 20:01:33 INFO - 'tabpaint']}, 20:01:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:01:33 INFO - 'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore', 20:01:33 INFO - 'tabpaint']}, 20:01:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:01:33 INFO - 'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore', 20:01:33 INFO - 'tabpaint']}, 20:01:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:01:33 INFO - 'tests': ['tsvgx', 20:01:33 INFO - 'tsvgr_opacity', 20:01:33 INFO - 'tart', 20:01:33 INFO - 'tscrollx', 20:01:33 INFO - 'cart']}, 20:01:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:01:33 INFO - 'tsvgr_opacity', 20:01:33 INFO - 'tart', 20:01:33 INFO - 'tscrollx', 20:01:33 INFO - 'cart']}, 20:01:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'talos_options': ['--disable-e10s'], 20:01:33 INFO - 'tests': ['tp5o']}, 20:01:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'tests': ['tp5o']}, 20:01:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'talos_options': ['--disable-e10s', 20:01:33 INFO - '--xperf_path', 20:01:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:33 INFO - 'tests': ['tp5n']}, 20:01:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'talos_options': ['--xperf_path', 20:01:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:33 INFO - 'tests': ['tp5n']}}, 20:01:33 INFO - 'talos.zip': {'path': '', 20:01:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:01:33 INFO - Running post-action listener: _resource_record_post_action 20:01:33 INFO - ##### 20:01:33 INFO - ##### Finished populate-webroot step (success) 20:01:33 INFO - ##### 20:01:33 INFO - ##### 20:01:33 INFO - ##### Running create-virtualenv step. 20:01:33 INFO - ##### 20:01:33 INFO - Running pre-action listener: _resource_record_pre_action 20:01:33 INFO - Running main action method: create_virtualenv 20:01:33 INFO - Creating virtualenv /builds/slave/test/build/venv 20:01:33 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:01:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:01:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:01:33 INFO - Using real prefix '/usr' 20:01:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:01:34 INFO - Installing distribute.............................................................................................................................................................................................done. 20:01:35 INFO - Installing pip.................done. 20:01:35 INFO - Return code: 0 20:01:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaec0e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf9c0>, '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 0x26d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d0d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', '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:01:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:01:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:01:35 INFO - Using env: {'DISPLAY': ':0', 20:01:35 INFO - 'HOME': '/home/cltbld', 20:01:35 INFO - 'LANG': 'en_US.UTF-8', 20:01:35 INFO - 'LANGUAGE': 'en_US:en', 20:01:35 INFO - 'LOGNAME': 'cltbld', 20:01:35 INFO - 'MAIL': '/var/mail/cltbld', 20:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:35 INFO - 'MOZ_NO_REMOTE': '1', 20:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:35 INFO - 'NO_EM_RESTART': '1', 20:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:35 INFO - 'PWD': '/builds/slave/test', 20:01:35 INFO - 'SHELL': '/bin/bash', 20:01:35 INFO - 'SHLVL': '1', 20:01:35 INFO - 'TERM': 'linux', 20:01:35 INFO - 'TMOUT': '86400', 20:01:35 INFO - 'USER': 'cltbld', 20:01:35 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', 20:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:35 INFO - '_': '/tools/buildbot/bin/python'} 20:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:36 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:01:36 INFO - Cleaning up... 20:01:36 INFO - Return code: 0 20:01:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:01:36 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:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:36 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:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:36 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 0x7ffaec0e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf9c0>, '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 0x26d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d0d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', '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:01:36 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:01:36 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:01:36 INFO - Using env: {'DISPLAY': ':0', 20:01:36 INFO - 'HOME': '/home/cltbld', 20:01:36 INFO - 'LANG': 'en_US.UTF-8', 20:01:36 INFO - 'LANGUAGE': 'en_US:en', 20:01:36 INFO - 'LOGNAME': 'cltbld', 20:01:36 INFO - 'MAIL': '/var/mail/cltbld', 20:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:36 INFO - 'MOZ_NO_REMOTE': '1', 20:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:36 INFO - 'NO_EM_RESTART': '1', 20:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:36 INFO - 'PWD': '/builds/slave/test', 20:01:36 INFO - 'SHELL': '/bin/bash', 20:01:36 INFO - 'SHLVL': '1', 20:01:36 INFO - 'TERM': 'linux', 20:01:36 INFO - 'TMOUT': '86400', 20:01:36 INFO - 'USER': 'cltbld', 20:01:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', 20:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:36 INFO - '_': '/tools/buildbot/bin/python'} 20:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:36 INFO - Downloading/unpacking psutil>=3.1.1 20:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:01:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:38 INFO - Installing collected packages: psutil 20:01:38 INFO - Running setup.py install for psutil 20:01:38 INFO - building 'psutil._psutil_linux' extension 20:01:38 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:01:38 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:01:38 INFO - building 'psutil._psutil_posix' extension 20:01:38 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:01:38 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:01:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:38 INFO - Successfully installed psutil 20:01:38 INFO - Cleaning up... 20:01:38 INFO - Return code: 0 20:01:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:38 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 0x7ffaec0e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf9c0>, '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 0x26d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d0d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', '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:01:38 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:01:38 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:01:38 INFO - Using env: {'DISPLAY': ':0', 20:01:38 INFO - 'HOME': '/home/cltbld', 20:01:38 INFO - 'LANG': 'en_US.UTF-8', 20:01:38 INFO - 'LANGUAGE': 'en_US:en', 20:01:38 INFO - 'LOGNAME': 'cltbld', 20:01:38 INFO - 'MAIL': '/var/mail/cltbld', 20:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:38 INFO - 'MOZ_NO_REMOTE': '1', 20:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:38 INFO - 'NO_EM_RESTART': '1', 20:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:38 INFO - 'PWD': '/builds/slave/test', 20:01:38 INFO - 'SHELL': '/bin/bash', 20:01:38 INFO - 'SHLVL': '1', 20:01:38 INFO - 'TERM': 'linux', 20:01:38 INFO - 'TMOUT': '86400', 20:01:38 INFO - 'USER': 'cltbld', 20:01:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', 20:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:38 INFO - '_': '/tools/buildbot/bin/python'} 20:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:01:39 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:01:39 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:01:39 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:01:39 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:01:39 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:01:39 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:01:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:01:41 INFO - Installing collected packages: mozsystemmonitor 20:01:41 INFO - Running setup.py install for mozsystemmonitor 20:01:41 INFO - Successfully installed mozsystemmonitor 20:01:41 INFO - Cleaning up... 20:01:41 INFO - Return code: 0 20:01:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:01:41 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:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:41 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:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:41 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 0x7ffaec0e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf9c0>, '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 0x26d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d0d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', '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:01:41 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:01:41 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:01:41 INFO - Using env: {'DISPLAY': ':0', 20:01:41 INFO - 'HOME': '/home/cltbld', 20:01:41 INFO - 'LANG': 'en_US.UTF-8', 20:01:41 INFO - 'LANGUAGE': 'en_US:en', 20:01:41 INFO - 'LOGNAME': 'cltbld', 20:01:41 INFO - 'MAIL': '/var/mail/cltbld', 20:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:41 INFO - 'MOZ_NO_REMOTE': '1', 20:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:41 INFO - 'NO_EM_RESTART': '1', 20:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:41 INFO - 'PWD': '/builds/slave/test', 20:01:41 INFO - 'SHELL': '/bin/bash', 20:01:41 INFO - 'SHLVL': '1', 20:01:41 INFO - 'TERM': 'linux', 20:01:41 INFO - 'TMOUT': '86400', 20:01:41 INFO - 'USER': 'cltbld', 20:01:41 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', 20:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:41 INFO - '_': '/tools/buildbot/bin/python'} 20:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:41 INFO - Downloading/unpacking blobuploader==1.2.4 20:01:41 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:01:41 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:01:41 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:01:41 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:01:41 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:01:41 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:01:43 INFO - Downloading blobuploader-1.2.4.tar.gz 20:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:01:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:01:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:43 INFO - Downloading docopt-0.6.1.tar.gz 20:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:01:44 INFO - Installing collected packages: blobuploader, requests, docopt 20:01:44 INFO - Running setup.py install for blobuploader 20:01:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:01:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:01:44 INFO - Running setup.py install for requests 20:01:44 INFO - Running setup.py install for docopt 20:01:44 INFO - Successfully installed blobuploader requests docopt 20:01:44 INFO - Cleaning up... 20:01:44 INFO - Return code: 0 20:01:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:44 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 0x7ffaec0e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf9c0>, '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 0x26d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d0d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', '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:01:44 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:01:44 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:01:44 INFO - Using env: {'DISPLAY': ':0', 20:01:44 INFO - 'HOME': '/home/cltbld', 20:01:44 INFO - 'LANG': 'en_US.UTF-8', 20:01:44 INFO - 'LANGUAGE': 'en_US:en', 20:01:44 INFO - 'LOGNAME': 'cltbld', 20:01:44 INFO - 'MAIL': '/var/mail/cltbld', 20:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:44 INFO - 'MOZ_NO_REMOTE': '1', 20:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:44 INFO - 'NO_EM_RESTART': '1', 20:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:44 INFO - 'PWD': '/builds/slave/test', 20:01:44 INFO - 'SHELL': '/bin/bash', 20:01:44 INFO - 'SHLVL': '1', 20:01:44 INFO - 'TERM': 'linux', 20:01:44 INFO - 'TMOUT': '86400', 20:01:44 INFO - 'USER': 'cltbld', 20:01:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', 20:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:44 INFO - '_': '/tools/buildbot/bin/python'} 20:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:01:44 INFO - Running setup.py (path:/tmp/pip-RyDXR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:01:44 INFO - Running setup.py (path:/tmp/pip-xIjUdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:01:45 INFO - Running setup.py (path:/tmp/pip-AFjRw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:01:45 INFO - Running setup.py (path:/tmp/pip-jFSEQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:01:45 INFO - Running setup.py (path:/tmp/pip-HPrVyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:01:45 INFO - Running setup.py (path:/tmp/pip-U9cIP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:01:45 INFO - Running setup.py (path:/tmp/pip-VBve2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:01:45 INFO - Running setup.py (path:/tmp/pip-qdX_vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:01:45 INFO - Running setup.py (path:/tmp/pip-4rEqt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:01:45 INFO - Running setup.py (path:/tmp/pip-SFFBbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:01:45 INFO - Running setup.py (path:/tmp/pip-ZfUvcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:01:45 INFO - Running setup.py (path:/tmp/pip-dIzUL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:01:45 INFO - Running setup.py (path:/tmp/pip-aeVRR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:01:45 INFO - Running setup.py (path:/tmp/pip-nujEcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:45 INFO - Running setup.py (path:/tmp/pip-RVE7VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:01:45 INFO - Running setup.py (path:/tmp/pip-jDrsVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:01:46 INFO - Running setup.py (path:/tmp/pip-CKuj3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:01:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:01:46 INFO - Running setup.py install for manifestparser 20:01:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Running setup.py install for mozcrash 20:01:46 INFO - Running setup.py install for mozdebug 20:01:46 INFO - Running setup.py install for mozdevice 20:01:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Running setup.py install for mozfile 20:01:46 INFO - Running setup.py install for mozhttpd 20:01:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Running setup.py install for mozinfo 20:01:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Running setup.py install for mozInstall 20:01:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:01:46 INFO - Running setup.py install for mozleak 20:01:47 INFO - Running setup.py install for mozlog 20:01:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:01:47 INFO - Running setup.py install for moznetwork 20:01:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:01:47 INFO - Running setup.py install for mozprocess 20:01:47 INFO - Running setup.py install for mozprofile 20:01:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:01:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:01:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:01:47 INFO - Running setup.py install for mozrunner 20:01:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:01:47 INFO - Running setup.py install for mozscreenshot 20:01:47 INFO - Running setup.py install for moztest 20:01:47 INFO - Running setup.py install for mozversion 20:01:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:01:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:01:47 INFO - Cleaning up... 20:01:47 INFO - Return code: 0 20:01:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:47 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 0x7ffaec0e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf9c0>, '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 0x26d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d0d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', '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:01:47 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:01:47 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:01:47 INFO - Using env: {'DISPLAY': ':0', 20:01:47 INFO - 'HOME': '/home/cltbld', 20:01:47 INFO - 'LANG': 'en_US.UTF-8', 20:01:47 INFO - 'LANGUAGE': 'en_US:en', 20:01:47 INFO - 'LOGNAME': 'cltbld', 20:01:47 INFO - 'MAIL': '/var/mail/cltbld', 20:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:47 INFO - 'MOZ_NO_REMOTE': '1', 20:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:47 INFO - 'NO_EM_RESTART': '1', 20:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:47 INFO - 'PWD': '/builds/slave/test', 20:01:47 INFO - 'SHELL': '/bin/bash', 20:01:47 INFO - 'SHLVL': '1', 20:01:47 INFO - 'TERM': 'linux', 20:01:47 INFO - 'TMOUT': '86400', 20:01:47 INFO - 'USER': 'cltbld', 20:01:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', 20:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:47 INFO - '_': '/tools/buildbot/bin/python'} 20:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:01:48 INFO - Running setup.py (path:/tmp/pip-coDjJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:01:48 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:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:01:48 INFO - Running setup.py (path:/tmp/pip-KfBrwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:01:48 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:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:01:48 INFO - Running setup.py (path:/tmp/pip-wtT9NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:01:48 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:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:01:48 INFO - Running setup.py (path:/tmp/pip-PHza4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:01:48 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:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:01:48 INFO - Running setup.py (path:/tmp/pip-uhY20L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:01:48 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:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:01:48 INFO - Running setup.py (path:/tmp/pip-VemJ8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:01:48 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:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:01:48 INFO - Running setup.py (path:/tmp/pip-yAT3Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:01:48 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:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:01:48 INFO - Running setup.py (path:/tmp/pip-7wgqbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:01:48 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:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:01:48 INFO - Running setup.py (path:/tmp/pip-qfmWGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:01:48 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:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:01:48 INFO - Running setup.py (path:/tmp/pip-yBAW9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:01:48 INFO - Running setup.py (path:/tmp/pip-CrmiKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:01:48 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:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:01:48 INFO - Running setup.py (path:/tmp/pip-ONGg7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:01:49 INFO - Running setup.py (path:/tmp/pip-LtcU0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:01:49 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:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:01:49 INFO - Running setup.py (path:/tmp/pip-Ybf8AR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:49 INFO - Running setup.py (path:/tmp/pip-7Aw7Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:49 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:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:01:49 INFO - Running setup.py (path:/tmp/pip-AC9y42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:01:49 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:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:01:49 INFO - Running setup.py (path:/tmp/pip-aTA35I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:01:49 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:01:49 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:01:49 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:01:49 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:01:49 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:01:49 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:01:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:51 INFO - Downloading blessings-1.6.tar.gz 20:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:01:51 INFO - Installing collected packages: blessings 20:01:51 INFO - Running setup.py install for blessings 20:01:51 INFO - Successfully installed blessings 20:01:51 INFO - Cleaning up... 20:01:51 INFO - Return code: 0 20:01:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:01:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:01:51 INFO - Reading from file tmpfile_stdout 20:01:51 INFO - Current package versions: 20:01:51 INFO - argparse == 1.2.1 20:01:51 INFO - blessings == 1.6 20:01:51 INFO - blobuploader == 1.2.4 20:01:51 INFO - docopt == 0.6.1 20:01:51 INFO - manifestparser == 1.1 20:01:51 INFO - mozInstall == 1.12 20:01:51 INFO - mozcrash == 0.17 20:01:51 INFO - mozdebug == 0.1 20:01:51 INFO - mozdevice == 0.48 20:01:51 INFO - mozfile == 1.2 20:01:51 INFO - mozhttpd == 0.7 20:01:51 INFO - mozinfo == 0.9 20:01:51 INFO - mozleak == 0.1 20:01:51 INFO - mozlog == 3.2 20:01:51 INFO - moznetwork == 0.27 20:01:51 INFO - mozprocess == 0.22 20:01:51 INFO - mozprofile == 0.28 20:01:51 INFO - mozrunner == 6.11 20:01:51 INFO - mozscreenshot == 0.1 20:01:51 INFO - mozsystemmonitor == 0.3 20:01:51 INFO - moztest == 0.7 20:01:51 INFO - mozversion == 1.4 20:01:51 INFO - psutil == 3.1.1 20:01:51 INFO - requests == 1.2.3 20:01:51 INFO - wsgiref == 0.1.2 20:01:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:51 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:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:51 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:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:51 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 0x7ffaec0e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf9c0>, '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 0x26d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d0d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', '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:01:51 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:01:51 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:01:51 INFO - Using env: {'DISPLAY': ':0', 20:01:51 INFO - 'HOME': '/home/cltbld', 20:01:51 INFO - 'LANG': 'en_US.UTF-8', 20:01:51 INFO - 'LANGUAGE': 'en_US:en', 20:01:51 INFO - 'LOGNAME': 'cltbld', 20:01:51 INFO - 'MAIL': '/var/mail/cltbld', 20:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:51 INFO - 'MOZ_NO_REMOTE': '1', 20:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:51 INFO - 'NO_EM_RESTART': '1', 20:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:51 INFO - 'PWD': '/builds/slave/test', 20:01:51 INFO - 'SHELL': '/bin/bash', 20:01:51 INFO - 'SHLVL': '1', 20:01:51 INFO - 'TERM': 'linux', 20:01:51 INFO - 'TMOUT': '86400', 20:01:51 INFO - 'USER': 'cltbld', 20:01:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', 20:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:51 INFO - '_': '/tools/buildbot/bin/python'} 20:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:51 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:01:51 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:01:51 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:01:51 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:01:51 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:01:51 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:01:51 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:01:51 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:01:51 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:01:51 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:01:51 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:01:51 INFO - Cleaning up... 20:01:51 INFO - Return code: 0 20:01:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:01:51 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:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:51 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:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:51 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 0x7ffaec0e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf9c0>, '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 0x26d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d0d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', '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:01:51 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:01:51 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:01:51 INFO - Using env: {'DISPLAY': ':0', 20:01:51 INFO - 'HOME': '/home/cltbld', 20:01:51 INFO - 'LANG': 'en_US.UTF-8', 20:01:51 INFO - 'LANGUAGE': 'en_US:en', 20:01:51 INFO - 'LOGNAME': 'cltbld', 20:01:51 INFO - 'MAIL': '/var/mail/cltbld', 20:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:51 INFO - 'MOZ_NO_REMOTE': '1', 20:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:51 INFO - 'NO_EM_RESTART': '1', 20:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:51 INFO - 'PWD': '/builds/slave/test', 20:01:51 INFO - 'SHELL': '/bin/bash', 20:01:51 INFO - 'SHLVL': '1', 20:01:51 INFO - 'TERM': 'linux', 20:01:51 INFO - 'TMOUT': '86400', 20:01:51 INFO - 'USER': 'cltbld', 20:01:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', 20:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:51 INFO - '_': '/tools/buildbot/bin/python'} 20:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:52 INFO - Downloading/unpacking jsonschema 20:01:52 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:01:52 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:01:52 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:01:52 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:01:52 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:01:52 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:01:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:01:53 INFO - Downloading/unpacking functools32 (from jsonschema) 20:01:53 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:01:53 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:01:53 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:01:53 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:01:53 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:01:53 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:01:54 INFO - Downloading functools32-3.2.3-2.tar.gz 20:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:01:54 INFO - warning: no files found matching '*.txt' 20:01:54 INFO - no previously-included directories found matching 'build' 20:01:54 INFO - no previously-included directories found matching 'dist' 20:01:54 INFO - no previously-included directories found matching '.git*' 20:01:54 INFO - Installing collected packages: jsonschema, functools32 20:01:54 INFO - Running setup.py install for functools32 20:01:54 INFO - warning: no files found matching '*.txt' 20:01:54 INFO - no previously-included directories found matching 'build' 20:01:54 INFO - no previously-included directories found matching 'dist' 20:01:54 INFO - no previously-included directories found matching '.git*' 20:01:54 INFO - Successfully installed jsonschema functools32 20:01:54 INFO - Cleaning up... 20:01:54 INFO - Return code: 0 20:01:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:01:54 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:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:54 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:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaec0e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2640770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cf9c0>, '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 0x26d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d0d50>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', '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:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:01:54 INFO - Using env: {'DISPLAY': ':0', 20:01:54 INFO - 'HOME': '/home/cltbld', 20:01:54 INFO - 'LANG': 'en_US.UTF-8', 20:01:54 INFO - 'LANGUAGE': 'en_US:en', 20:01:54 INFO - 'LOGNAME': 'cltbld', 20:01:54 INFO - 'MAIL': '/var/mail/cltbld', 20:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:54 INFO - 'MOZ_NO_REMOTE': '1', 20:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:54 INFO - 'NO_EM_RESTART': '1', 20:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:54 INFO - 'PWD': '/builds/slave/test', 20:01:54 INFO - 'SHELL': '/bin/bash', 20:01:54 INFO - 'SHLVL': '1', 20:01:54 INFO - 'TERM': 'linux', 20:01:54 INFO - 'TMOUT': '86400', 20:01:54 INFO - 'USER': 'cltbld', 20:01:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', 20:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:54 INFO - '_': '/tools/buildbot/bin/python'} 20:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:54 INFO - Downloading/unpacking flake8 20:01:54 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:01:54 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:01:54 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:01:54 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:01:54 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:01:54 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:01:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:01:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:01:56 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:01:56 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:01:56 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:01:56 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:01:56 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:01:56 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:01:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:01:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:01:56 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:01:56 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:01:56 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:01:56 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:01:56 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:01:56 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:01:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:01:57 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:01:57 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:01:57 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:01:57 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:01:57 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:01:57 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:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:01:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:57 INFO - no previously-included directories found matching 'docs/_build' 20:01:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:01:57 INFO - Running setup.py install for pep8 20:01:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:57 INFO - no previously-included directories found matching 'docs/_build' 20:01:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:01:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:01:57 INFO - Cleaning up... 20:01:57 INFO - Return code: 0 20:01:57 INFO - Running post-action listener: _resource_record_post_action 20:01:57 INFO - Running post-action listener: _start_resource_monitoring 20:01:57 INFO - Starting resource monitoring. 20:01:57 INFO - ##### 20:01:57 INFO - ##### Finished create-virtualenv step (success) 20:01:57 INFO - ##### 20:01:57 INFO - ##### 20:01:57 INFO - ##### Running install step. 20:01:57 INFO - ##### 20:01:57 INFO - Running pre-action listener: _resource_record_pre_action 20:01:57 INFO - Running main action method: install 20:01:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:01:57 INFO - Reading from file tmpfile_stdout 20:01:57 INFO - Detecting whether we're running mozinstall >=1.0... 20:01:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:01:58 INFO - Reading from file tmpfile_stdout 20:01:58 INFO - Output received: 20:01:58 INFO - Usage: mozinstall [options] installer 20:01:58 INFO - Options: 20:01:58 INFO - -h, --help show this help message and exit 20:01:58 INFO - -d DEST, --destination=DEST 20:01:58 INFO - Directory to install application into. [default: 20:01:58 INFO - "/builds/slave/test"] 20:01:58 INFO - --app=APP Application being installed. [default: firefox] 20:01:58 INFO - mkdir: /builds/slave/test/build/application 20:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:02:14 INFO - Reading from file tmpfile_stdout 20:02:14 INFO - Output received: 20:02:14 INFO - /builds/slave/test/build/application/firefox/firefox 20:02:14 INFO - Running post-action listener: _resource_record_post_action 20:02:14 INFO - ##### 20:02:14 INFO - ##### Finished install step (success) 20:02:14 INFO - ##### 20:02:14 INFO - ##### 20:02:14 INFO - ##### Running run-tests step. 20:02:14 INFO - ##### 20:02:14 INFO - Running pre-action listener: _resource_record_pre_action 20:02:14 INFO - Running main action method: run_tests 20:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:02:14 INFO - Python 2.7.3 20:02:14 INFO - Return code: 0 20:02:14 INFO - grabbing minidump binary from tooltool 20:02: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:02:14 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 0x26cf9c0>, '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 0x26d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:02:14 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:02:14 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:02:14 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:02:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:14 INFO - Return code: 0 20:02:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:02:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:02:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:02:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:02:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:02:15 INFO - Return code: 0 20:02:15 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/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:02:15 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/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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:02:15 INFO - Using env: {'DISPLAY': ':0', 20:02:15 INFO - 'HOME': '/home/cltbld', 20:02:15 INFO - 'LANG': 'en_US.UTF-8', 20:02:15 INFO - 'LANGUAGE': 'en_US:en', 20:02:15 INFO - 'LOGNAME': 'cltbld', 20:02:15 INFO - 'MAIL': '/var/mail/cltbld', 20:02:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:02:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:15 INFO - 'MOZ_NO_REMOTE': '1', 20:02:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:15 INFO - 'NO_EM_RESTART': '1', 20:02:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:15 INFO - 'PWD': '/builds/slave/test', 20:02:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:02:15 INFO - 'SHELL': '/bin/bash', 20:02:15 INFO - 'SHLVL': '1', 20:02:15 INFO - 'TERM': 'linux', 20:02:15 INFO - 'TMOUT': '86400', 20:02:15 INFO - 'USER': 'cltbld', 20:02:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444', 20:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:15 INFO - '_': '/tools/buildbot/bin/python'} 20:02:15 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/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:02:15 INFO - mozversion application_buildid: 20160530173007 20:02:15 INFO - mozversion application_changeset: 3a87296fe4145138c2ce15512bb31f76fe869cb4 20:02:15 INFO - mozversion application_display_name: Nightly 20:02:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:15 INFO - mozversion application_name: Firefox 20:02:15 INFO - mozversion application_remotingname: firefox 20:02:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:02:15 INFO - mozversion application_vendor: Mozilla 20:02:15 INFO - mozversion application_version: 49.0a1 20:02:15 INFO - mozversion platform_buildid: 20160530173007 20:02:15 INFO - mozversion platform_changeset: 3a87296fe4145138c2ce15512bb31f76fe869cb4 20:02:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:02:15 INFO - mozversion platform_version: 49.0a1 20:02:15 INFO - using testdate: 1464663735 20:02:15 INFO - actual date: 1464663735 20:02:15 INFO - starting webserver on 'localhost:52845' 20:02:15 INFO - SUITE-START | Running 2 tests 20:02:15 INFO - TEST-START | dromaeo_css 20:02:15 INFO - operating with platform_type : linux_ 20:02:15 INFO - Initialising browser for dromaeo_css test... 20:02:15 INFO - TEST-INFO | started process 16651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpalFxKm/profile http://localhost:52845/getInfo.html) 20:02:20 INFO - PROCESS | 16651 | __metrics Screen width/height:1600/1200 20:02:20 INFO - PROCESS | 16651 | colorDepth:24 20:02:20 INFO - PROCESS | 16651 | Browser inner width/height: 1024/697 20:02:20 INFO - PROCESS | 16651 | __metrics 20:02:20 ERROR - PROCESS | 16651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:02:21 INFO - TEST-INFO | 16651: exit 0 20:02:21 INFO - Browser initialized. 20:02:21 INFO - Running cycle 1/1 for dromaeo_css test... 20:02:21 INFO - TEST-INFO | started process 16769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpalFxKm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:33 INFO - PROCESS | 16769 | RSS: Main: 167047168 20:02:33 INFO - PROCESS | 16769 | 20:03:23 INFO - PROCESS | 16769 | 1464663803097 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:05:30 INFO - PROCESS | 16769 | Cycle 1(1): loaded http://localhost:52845/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52845/tests/dromaeo/cssquery-ext.html) 20:05:31 INFO - PROCESS | 16769 | RSS: Main: 170254336 20:05:31 INFO - PROCESS | 16769 | 20:08:33 INFO - PROCESS | 16769 | Cycle 1(1): loaded http://localhost:52845/tests/dromaeo/cssquery-ext.html (next: http://localhost:52845/tests/dromaeo/cssquery-jquery.html) 20:08:34 INFO - PROCESS | 16769 | RSS: Main: 169381888 20:08:34 INFO - PROCESS | 16769 | 20:11:36 INFO - PROCESS | 16769 | Cycle 1(1): loaded http://localhost:52845/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52845/tests/dromaeo/cssquery-mootools.html) 20:11:36 INFO - PROCESS | 16769 | RSS: Main: 170778624 20:11:36 INFO - PROCESS | 16769 | 20:14:38 INFO - PROCESS | 16769 | Cycle 1(1): loaded http://localhost:52845/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52845/tests/dromaeo/cssquery-prototype.html) 20:14:39 INFO - PROCESS | 16769 | RSS: Main: 168407040 20:14:39 INFO - PROCESS | 16769 | 20:17:41 INFO - PROCESS | 16769 | Cycle 1(1): loaded http://localhost:52845/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52845/tests/dromaeo/cssquery-yui.html) 20:17:42 INFO - PROCESS | 16769 | RSS: Main: 170565632 20:17:42 INFO - PROCESS | 16769 | 20:20:45 INFO - PROCESS | 16769 | Cycle 1(1): loaded http://localhost:52845/tests/dromaeo/cssquery-yui.html (next: http://localhost:52845/tests/dromaeo/cssquery-dojo.html) 20:20:45 INFO - PROCESS | 16769 | RSS: Main: 171483136 20:20:45 INFO - PROCESS | 16769 | 20:20:45 INFO - PROCESS | 16769 | __start_tp_report 20:20:45 INFO - PROCESS | 16769 | _x_x_mozilla_page_load 20:20:45 INFO - PROCESS | 16769 | _x_x_mozilla_page_load_details 20:20:45 INFO - PROCESS | 16769 | |i|pagename|runs| 20:20:45 INFO - PROCESS | 16769 | |0;dojo.html;3079.5226739855325;3125.7186853183216;3133.8746450141994;3164.9208769780753;3178.014815407224;5354.196870469432;5357.892842143155;5364.034473794715;5410.242566040757;5428.61999660023;5274.208868669702;5375.43557926417;5442.510174084332;5450.100733378988;5464;4913.656044076907;4928.334674818907;4974.452810190876;5083.212102124176;5133.281340612299;4925.236588328797;5063.721495317756;5076.74616269185;5109.948900511003;5111.003354345904;4882.218844984785;4923.679960802537;4949.084419382426;4992.725400102993;4995.825146119886;4988.052270068712;4992.151334273146;4994.800207991676;4995.800167993276;5046.369203849519;4962.578180854632;4963.255511673242;4963.801447942078;4982.17794063979;4997.0505603935135;5098.592112631018;5227.18978558324;5284.894302113975;5292.497212764782;5329;5822.301323841124;5822.7088645567555;5825.592208545403;5826.650400975913;5828.3297420796725;5641.407652196543;5863.355030946593;5869.090291004901;5871.970640146815;5884.617499862496;5418.864528386783;5431.293931788842;5459.153831156177;5493.505584497454;5502.614816962814;5988.431099045583;5990.041593345044;5991.910121348184;5993.250843644544;5998.490128339053;5571.4150014248735;5580.135079062752;5742.827715168552;5752.07966725322;5760.308762948389;5689.943100569024;5742.08126699726;5742.08126699726;5743.56923230751;5790.218320526759;5558.805441809517;5667.574931880125;5693.373728889819;5726.026575482178;5727.5131613812455;5763.077907534858;5781.971090144522;5786.508146807484;5823.88352232953;5861.6189947653265;4407.669424793154;4438.7114837535455;4440.089781594766;4449.087936972913;4466.531014243523;3886.514185726784;3900.258950799339;3919.666828319625;3941.52701675795;4009.558948515661;5565.916511252334;5576.86057848557;5588.888222235532;5591;5631.380548139783;5812.593118481665;5855.736491857877;5859.560532960045;5868.589198756046;5874.970625146932;5412.512873841373;5521.475459831309;5542.722863856791;5555.333359996826;5569.832905012775;5003.199488081889;5029.1443690691885;5029.1450453423;5029.170186919117;5042.697438153723;6036.215292012098;6038.969805150946;6041.305249896318;6041.848953776191;6050.152978583002;5705.115707065412;5784.248047753765;5826.679532625577;5827.067669172912;5846.298444186725;5961.701914904151;6017.578769486269;6021.819345419644;6024.849378765566;6025.246844144482;5554.97222513901;5700.173474846207;5706.144078388275;5707.514861236841;5709.800156994485;5805.158252053513;5832;5853.09277062056;5883.882322353615;5889.234399528034;5668.291463567054;5697.259356283656;5716.485516303553;5724.112762521816;5725.6850873202375;5465.699386533779;5514.365847927379;5702.6863522506665;5714.771409143587;5722.055860782924;5439.129739241703;5443.020256353736;5477.616566840283;5484.808031718871;5559.19391688211;5605.383407825055;5716.056850619768;5729.169270455844;5730.169125476866;5752.712364381848;5441.918371224514;5622.859428514156;5629.324481062299;5632.690202038927;5639.54883609302 20:20:45 INFO - PROCESS | 16769 | |1;ext.html;596.2368168744007;645.1419611916152;651.1014799576584;660.4353277947356;661.8014595621312;42674.78662606687;43725.34411983823;43933.340999884946;44021.339679904784;48006.279905801355;46465;46807.29789053158;47135.76432117843;47179;47255.52744472554;8752.299816014704;8985.14641109097;8994.595243214038;9013.18881300686;9039.59321830516;8863.157999989991;8922.509261990588;8928.821423571524;8942.41874278173;8974.86537701935;8962.507062111614;8970.551472426385;9025.097490250955;9036.728898133033;9055.094490550959;8974.910250897505;9004.144606262395;9005.459672419644;9024.278057755397;9048.683296084606;8924.643014279422;8986.146316100025;9009.054049324857;9012.27901767857;9028.052054534244;40373.394399084034;40435.191296174205;40554;40998;41047.7947610263;3663.285659296438;3689.9262014759556;3692.5015122958325;3966.127451960564;3995.7402768819934;32482;32927.83536082304;32928.341433171445;32932.176695582566;33760;4392.0776636906285;4444.422452695767;4449.977750111261;4569.908601827978;4605.608523275526;353616;354086;354986.2250688756;355552;356564.9999999974;60315.69842150849;60570;60850.69574652187;61057;61404.385956139864;35103.29793404118;63789.36210637834;64412;64449.355506444335;64670.353296466434;16330.67338653244;17137;17238.913805430893;17296.135193240287;17312;12974;13099.738005239842;13118.737625247633;13155.802662960063;13175.275359855108;19664.60670786605;19989.700154497696;20006;20065.899670501847;20127.899360503103;7134.571925684476;7307.3423391894985;7459;7474.7757567273065;7549.131849837229;990.6582229130938;1073.9624113156;1127.1264769803468;1155.8035134027236;1175.735459521601;32533;33251.33497330088;33323.3335333292;33404.66595334064;33473.49789753155;1148.833419154218;1173.137743758337;1239.6838806104565;1256.8931640810633;1297.9221246725226;17108.315667373416;17414.738778918327;17555.648887022187;17564.121793910253;17673.20470578827;549749;558311;560863.5654573853;562045;564249;59129;59137.40862591319;59649.70175149183;59732.402675972684;59812.70093649591;1337.3647517429142;1381.7650999330137;1394.3446580107536;1401.6776141487514;1410.0200360749182;31347.373052538365;31494.685053149176;31700;32345.676543234265;32598.837005814818;51875.74062129665;52019.2197117036;52115.21827172671;52469.21296180637;52674.736626316626;450223;458075;460258;460409;460435;28239.43521129607;28347.716522834507;28637.14088577346;28638.570421443277;28664.283392915346;49100;49282;49910.75044624753;50103;50374;39683.60316396914;41615;41952;42703.78648106739;42838.78580607202;40840.38739418852;40947.795261024694;41060.38409423801;41673;41758.79120604499;40248.3962740565;41918;42590.14819703527;42614.36078458764;42634;35744.463833042006;37726.245475089796;37873.43189852099;38147.809260953516;38573.614263857;28476.572851407658;28704.712952870203;28903.7109628901;29006.419871602873;29312.560311594916 20:20:45 INFO - PROCESS | 16769 | |2;jquery.html;386.93035253654347;386.94776205212287;389.791461568061;394.8440366055408;413.495535446755;17783.37758178464;19295.807041929576;19570.31503897364;19657.901710491446;20377.898110509464;17609.471715848515;17886.373976910778;18237.270509179616;18269.36057237997;18356.816431835712;5475.698836563987;5478.205660179272;5604.075327570946;5642.802501912434;5678.375378708339;5565.805196818113;5568.9443105569035;5591.1054231323;5607.355154157283;5610.24261724666;5403.621746477748;5503.064479038573;5527.944720552803;5535.474129957668;5570.888582228353;5460.672359658413;5476.91784623231;5484.067708489566;5531.419200983899;5535.474129957668;4715;4857.951420485785;4936.605071594264;4949.331840201563;4965.379327584052;22634.547309053727;22709.205177818698;22815.42961425961;23074.538509229722;23200.187993420317;2293.7591552886875;2308.9769102309097;2384.892679829412;2398.2445529658103;2475.084218839023;14423.711525769426;14648.194349310783;14720.852791472056;14763.26183690822;15095.24523773818;1892.9175164682733;1958.109060377539;1997;2036.8879711615855;2050.764162121345;78746.21253787504;78808.21191788066;80702.59648701777;81794.18205817926;82102;10242.53908574116;10431.791364172674;10658.987396197348;11041.779164416666;11217.551297948154;14388.20864852443;14458.277086145861;14494.420223191166;14494.492692755703;14509.201993890227;7769.028871391076;7825.100113486908;7889.723859664884;7895.210478952059;8042.437029407885;7553.697852085965;7555.09338879338;7609.381756370593;7705.4220933430215;7927.286544211049;6267.341929097379;6456.257530383972;6516.2506311773805;6528.347165283529;6592.241892182365;1853.6634058694297;1854.9907250463662;1855.3135339924045;1861.9162137703836;1920.6542822291842;960.481340076351;1078.4823284823328;1083.7778255457613;1122.0014187373245;1147.3230793831679;19063.332783352515;19718.112684929212;19924.60150796976;19976.800231997495;20236.59526809485;1063.4310643805682;1067.295584913953;1097.5280629329466;1107.6953837694698;1110.2006555280186;10924.945375273232;11438;11491.482883270273;11520.711982200344;11534.077273818075;509726;514378;522491;525089;526288;85298.5735071333;85311.57344213239;85625.57187214024;86221;86714.56642716873;1018.1651046142092;1034.1933292032227;1036.7045392063226;1038.1487180511908;1054.3989925742408;17363;17392.47822565325;17565.209565569836;17718.82281177172;17891.642167156322;39072.27293131781;39544.40683389809;39576;39743.40384894171;40505;52869;58428.4157158423;58867;60752;61087;7560.130584982578;7686.846263074595;7805.726799561988;8194.303484203909;8422.452540584842;9358.066685124328;12494.937525312314;13370.665733356744;13508.44652864933;13520.72958540804;11863.940680296544;12015.939920300343;12029.578964736193;12165.939170304091;12281.631551053482;11346.546138154712;11427.771444571228;11552.42237888119;11576.88423115758;11876.55302653805;6405.327440618668;10092.495375231356;11912.344821034927;12203.69490762738;12436.378181090728;8468.3648726347;8730.781730456536;8769.736907892773;8776.868346974672;8897.199252067345;10956.945215273872;12126.454309556268;12163.148579599343;12285.324307163191;12452.564160254347 20:20:45 INFO - PROCESS | 16769 | |3;mootools.html;1491.0755331694347;1519.3239008641156;1661.3520726916504;1782.8841125326844;1789.6241789224262;7387.556746595194;7980.401469889753;8182.263596276342;8713.259372953298;8737.95631021844;7957.124716281219;8166.795830104235;8229.135940726228;8231.053428855683;8233.876491852627;2270.3302525754943;2295.2081531871477;2304.72343318802;2309.2494939144763;2313.8958746856347;2245.9663105053355;2278.362058623588;2287.4281429642588;2289.2559918026623;2293.334932869466;2244.7755224477587;2246.8202543796538;2269.126386341254;2297.6783250344965;2298.367948814081;2229.1194977983687;2236.7204099487562;2256.7856053674873;2259.6497542880797;2265.4223173090923;2211.7677643847487;2262.1403866530777;2264.3320220534815;2268.410213344542;2270.7956283934527;8150.510969341858;8193.09875913649;8212.958935205286;8226.300764435031;8236.341092712568;4879.951200487985;5017.473165317662;5018.447970723218;5029.949700502984;5048.091343558158;3303.9174020649434;3396.5225127069803;3439.398105331582;3559.4482855157235;3587.820608969541;1081.3511892864296;1100.5982816272003;1116.6650004998548;1122.4275619434065;1139.2196345503357;11321.20751547392;11328.830067548912;11342.092632589372;11372.48823802931;11381.374024428653;4484.2376795944765;4532.184206842734;4641.721496710141;4656.278276867091;4680.602148817388;9740.46427446483;9826.65606703762;9843.064908833649;9853.50732463374;9874.605015799287;5057.342545469065;5058.114829904752;5101.846944591668;5107.080725469377;5108.56577190943;4040.898977525527;4529.728216306966;4571.611413029929;4657.858824587997;4691.953080469151;3941.5664276929515;3943.684505239574;4044.8179831907637;4060.147369052473;4080.449139366207;1305.7845455499926;1306.0596370613334;1319.5249710104354;1336.9732605347838;1337.3981708231336;1004.1765752083221;1010.3382284603597;1011.4285428732743;1025.9538320775582;1035.471909326234;5973.462388385066;6009.849753756191;6023.27720673522;6062.151298818169;6369.872602547923;962.2686758063782;976.2629214942673;1019.3425240719695;1025.600015993748;1035.3942943378058;4125.422440858282;4163.39630753539;4210.200061988213;4232.153569286155;4255.276602977501;10351.896481035094;10573;10579;10597;10637.946810266054;10477.738056548647;10552.788944221225;10562.524686389132;10570.365778053341;10595.311304765166;7584.469087163846;7886.211378862183;7910.762677119696;7944.126146123922;8121.918780812116;5853.736581853742;5906.557008224315;5965.4788029052315;6042.456178943916;6100.511959043177;9484.525773711424;9646.951765241129;9711.36876103051;9720.659776907774;9724.854127187957;9520.190783783455;9652.083052110038;9692.660756873758;9801.558929848032;9896.356736812084;6745.156855393076;7466.141393739572;7518.135414427192;7658.8085297868;7674.8081297968;8322.334213262804;8343.45767525109;8354.16458354184;8384.413091083565;8386.119457457124;7100.218975912749;7270.6728197230195;7364.079490063742;7394.963025185055;7518.661660225413;7177.497575169688;7230.240824713329;7254.746083887038;7275.381592564691;7294.161171465349;6730.125083739278;6764.425023872829;6799.626020568916;6840.076589660531;6848.486363522656;5068.701070458528;5188.147033789243;5238.4237733850005;5302.072137375867;5339.866503337447;5092.670891490927;5237.16205407133;5291.3121294231505;5365;5401.2168235606405 20:20:45 INFO - PROCESS | 16769 | |4;prototype.html;326.60317713977514;328.2745133255505;331.8921350561067;334.97152742016925;335.7683198592971;5646.729485865683;5652.180433837097;5676.176954341618;5682.119271512912;5699.430056994299;5553.666779993193;5556.9444305556935;5562.471565201299;5597.888042239153;5598.144946077499;4052.3516237402023;4197.9370309445385;4282.464691913511;4284.6786491013145;4304.569543045702;4257.318828987362;4263.403123562688;4274.358846173083;4283.100548884738;4316.6546676265825;4247;4285.9571404286025;4287.20686672965;4288;4306.676999225055;4015.558288588253;4270.996315865769;4280.850170244058;4286.378475121106;4286.892827679333;3719.702423806089;3726.2361215950664;3737.495438115874;3745.906352341186;3752.8123593820474;5372.57019438444;5385.7576409061685;5394.298741163623;5403.243545903577;5456.317960254968;4607.631389488833;4834.854954351375;4836.831875121801;4923;4944.058285320229;5779.133130030487;5790.971045144747;5844.44477774615;5872.941270587282;5885.205497257858;4074.185162967389;4078.9184216315803;4080.9795951020055;4102.297546518192;4105.856295029689;5908.202392676976;5973.761049558012;5997.940020599782;6003.199040287896;6170.84572885677;4134.297169481196;4134.503859536875;4141.26067051839;4166.312558427886;4197.706160568731;4173.1862286854375;4196.769177695195;4237.0466645005245;4241.427407300037;4253.298205796071;4692.929606055912;4799.232122860326;4799.592034677092;4805.975970120127;4815.807367705253;5861.681121747572;5866.70666466675;5875.764969401176;5892.823215303548;5936.1986131871645;1444.3500424808667;1465.5969608357573;1472.0873058703457;1473.4842805018159;1477.5050358129931;918.4397517514311;931.6552875436132;945.664289177346;957.2820384711466;995.5719040812376;5634.464725851038;5657.349404818417;5681.545476361881;5682.272509195526;5698.572607054488;5890.823275301748;5913.752773945959;5916.911246331309;5921.111833225051;5950.375210602911;5418.8916221675345;5577.386487486373;5728.312602487728;5749.712514374264;5790.971045144832;3177.8252196129433;3189.5215717642077;3190.941842511567;3197.6322722886703;3220.5330227117406;6130;6184.690765461709;6204.193454850931;6252.343503932113;6332.746690132343;6047.034713718059;6145.108959200891;6179.806168810008;6182.907256391068;6192.721327540272;6122.673384114098;6268.49852011838;6269.843253918689;6321;6338.366163383625;6021.157038014769;6052.093590518973;6052.6973651316375;6087.2999605044215;6101;5991.760329586942;6008.218931538872;6009.729562169626;6031.547633927561;6032.4570788629235;5983.551233657406;6244.2819075806865;6276.372362763687;6278.591891527036;6282.748690052346;4132.752034877917;4150.232207041707;4167.124903770242;4170.582941705805;4184.288670925889;6061.605995610271;6125.663088530174;6166.475849552839;6166.537509686881;6168.753249869955;5616.831495055155;5895.793647222326;5914.792982245773;5941.346451890375;5945.851353716192;5860.15027820955;5893.728980415739;5911.96540605401;5932.940670593412;5949.286085669747;5327.520523152934;5749.367569567428;5760.711964401847;5787.565932554991;5787.594868359174;5919.733611987557;5952.404759524013;5964.373740757332;5975.193348897843;5975.701214939322;5574.442555744393;5709.65742055478;5716.885662286814;5732.796112816355;5833.358330583717 20:20:45 INFO - PROCESS | 16769 | |5;yui.html;826.6114925984787;841.4908980067063;846.5005646668468;853.8121613245091;863.6674880171134;13305.733885322288;13489.258090805002;13503.527376541811;13577.389017494212;13672.726545469084;14084.154950702965;14248;14251.358688859;14258.928705356459;14264.643383915407;659.4757168051386;764.9235076492362;796.8007998000486;801.7153910361825;817.480899628734;800.4116974024116;802.2498963469146;804.7183485779989;805.255138996426;808.296781799832;859.5616235719797;861.8707193920899;862.1507814802414;862.4264863865521;862.7325529085972;851.43379652531;851.7955690634234;853.3855623950745;854.8290341931577;855.683397143061;617.6417677746941;620.9316975132732;622.1197006236171;622.757124721359;624.3475568031419;12872.485100595964;12892.613221603273;12916.870831291755;12917.22496650204;12932.87067129326;13904.51334203298;13984;14009.29953502331;14063.718725625431;14209.431622735077;11838.230515016496;11848.50434704537;11971.880281197251;12006.159568830186;12559.497620095186;3858.884233473;3905.453236546886;3915.882523524299;3931.2923673738715;4037.1521980384155;58170.70914645442;59514.10728839114;59977.40022599762;60102.69948650272;60152.69923650398;10737.51681174349;10954.890451095547;10986.340819550693;11042.944785276022;11076.833847492133;20519.897400512902;20658.690119648218;20740.06669699867;20795.480112996993;20876.895615521826;8070.959645201737;8266;8343.45767525109;8397.874031889527;8458.238758511763;4714.717116972924;4716.316134160527;4797.40032495938;4880.902381952341;4932.062908047459;3405.0976491229844;3489.4940233665975;3496.930061398758;3504.15900183954;3510.526078979356;578.6325683191204;628.9779857704958;658.0195508692015;660.1220376898809;667.5894324990096;758.9848203035908;763.9847203055908;776.5690042026729;786.5280831501053;795.3478147918651;9359.391639543408;9510.144087032062;9622.759431014281;9674.129328360481;9685.467299298465;658.9505787065893;687.8796210663114;793.2860425616991;794.3406972213049;809.1665584448028;4667.346571479996;4685.8594242172785;4757;4892.363992680928;4946.579540739078;71467.2853271471;74494.25505744982;75229.62385188148;76300;76380.61809690917;64378;67550.66224668846;67967.32032679609;68086.65956670285;68199.65900170467;61411.38588614146;61414.77170456566;61833.69083154645;62620.37379626236;63238.36761632417;9239.907600924174;9319.906800931903;9483.52582370865;9573.473458959825;9589.760255993377;39455.80272098621;39506.209875802895;40103;40261.1947761049;40925;52890;53308;53641;54117;55258.72370638282;10950.945245273722;11062.115030797357;11304.604338848101;11708.356040417859;11715.297082175097;12178.538575371012;12236.204646698292;12433.502659893864;12688.17526860751;13409.195448273134;12670.87329126697;12752.362381881054;12885.677858053623;13554.051216414757;13642.658933526343;12798.488060477477;12851.971842252784;12956;13331.266780327174;13352.198868067948;12423.875761242272;12590;12591.24452532851;12833.358332083546;12837.550685725955;10378.792424151627;10703.464826758787;10778.568857245622;10806.945965270123;10920.78158436811;10762.354258744188;10824.350538967687;10925.562977480811;10959.178061645567;11185.272957257752 20:20:45 INFO - PROCESS | 16769 | __end_tp_report 20:20:45 INFO - PROCESS | 16769 | __start_cc_report 20:20:45 INFO - PROCESS | 16769 | _x_x_mozilla_cycle_collect,343 20:20:45 INFO - PROCESS | 16769 | __end_cc_report 20:20:45 INFO - PROCESS | 16769 | __startTimestamp1464664845421__endTimestamp 20:20:45 INFO - PROCESS | 16769 | 20:20:45 INFO - PROCESS | 16769 | ------- Summary: start ------- 20:20:45 INFO - PROCESS | 16769 | Number of tests: 6 20:20:45 INFO - PROCESS | 16769 | 20:20:45 INFO - PROCESS | 16769 | [#0] dojo.html Cycles:165 Average:5394.42 Median:5576.86 stddev:609.40 (10.9%) stddev-sans-first:583.58 20:20:45 INFO - PROCESS | 16769 | Values: 3079.5 3125.7 3133.9 3164.9 3178.0 5354.2 5357.9 5364.0 5410.2 5428.6 5274.2 5375.4 5442.5 5450.1 5464.0 4913.7 4928.3 4974.5 5083.2 5133.3 4925.2 5063.7 5076.7 5109.9 5111.0 4882.2 4923.7 4949.1 4992.7 4995.8 4988.1 4992.2 4994.8 4995.8 5046.4 4962.6 4963.3 4963.8 4982.2 4997.1 5098.6 5227.2 5284.9 5292.5 5329.0 5822.3 5822.7 5825.6 5826.7 5828.3 5641.4 5863.4 5869.1 5872.0 5884.6 5418.9 5431.3 5459.2 5493.5 5502.6 5988.4 5990.0 5991.9 5993.3 5998.5 5571.4 5580.1 5742.8 5752.1 5760.3 5689.9 5742.1 5742.1 5743.6 5790.2 5558.8 5667.6 5693.4 5726.0 5727.5 5763.1 5782.0 5786.5 5823.9 5861.6 4407.7 4438.7 4440.1 4449.1 4466.5 3886.5 3900.3 3919.7 3941.5 4009.6 5565.9 5576.9 5588.9 5591.0 5631.4 5812.6 5855.7 5859.6 5868.6 5875.0 5412.5 5521.5 5542.7 5555.3 5569.8 5003.2 5029.1 5029.1 5029.2 5042.7 6036.2 6039.0 6041.3 6041.8 6050.2 5705.1 5784.2 5826.7 5827.1 5846.3 5961.7 6017.6 6021.8 6024.8 6025.2 5555.0 5700.2 5706.1 5707.5 5709.8 5805.2 5832.0 5853.1 5883.9 5889.2 5668.3 5697.3 5716.5 5724.1 5725.7 5465.7 5514.4 5702.7 5714.8 5722.1 5439.1 5443.0 5477.6 5484.8 5559.2 5605.4 5716.1 5729.2 5730.2 5752.7 5441.9 5622.9 5629.3 5632.7 5639.5 20:20:45 INFO - PROCESS | 16769 | 20:20:45 INFO - PROCESS | 16769 | [#1] ext.html Cycles:180 Average:62096.04 Median:42602.25 stddev:123315.77 (289.5%) stddev-sans-first:123575.26 20:20:45 INFO - PROCESS | 16769 | Values: 596.2 645.1 651.1 660.4 661.8 42674.8 43725.3 43933.3 44021.3 48006.3 46465.0 46807.3 47135.8 47179.0 47255.5 8752.3 8985.1 8994.6 9013.2 9039.6 8863.2 8922.5 8928.8 8942.4 8974.9 8962.5 8970.6 9025.1 9036.7 9055.1 8974.9 9004.1 9005.5 9024.3 9048.7 8924.6 8986.1 9009.1 9012.3 9028.1 40373.4 40435.2 40554.0 40998.0 41047.8 3663.3 3689.9 3692.5 3966.1 3995.7 32482.0 32927.8 32928.3 32932.2 33760.0 4392.1 4444.4 4450.0 4569.9 4605.6 353616.0 354086.0 354986.2 355552.0 356565.0 60315.7 60570.0 60850.7 61057.0 61404.4 35103.3 63789.4 64412.0 64449.4 64670.4 16330.7 17137.0 17238.9 17296.1 17312.0 12974.0 13099.7 13118.7 13155.8 13175.3 19664.6 19989.7 20006.0 20065.9 20127.9 7134.6 7307.3 7459.0 7474.8 7549.1 990.7 1074.0 1127.1 1155.8 1175.7 32533.0 33251.3 33323.3 33404.7 33473.5 1148.8 1173.1 1239.7 1256.9 1297.9 17108.3 17414.7 17555.6 17564.1 17673.2 549749.0 558311.0 560863.6 562045.0 564249.0 59129.0 59137.4 59649.7 59732.4 59812.7 1337.4 1381.8 1394.3 1401.7 1410.0 31347.4 31494.7 31700.0 32345.7 32598.8 51875.7 52019.2 52115.2 52469.2 52674.7 450223.0 458075.0 460258.0 460409.0 460435.0 28239.4 28347.7 28637.1 28638.6 28664.3 49100.0 49282.0 49910.8 50103.0 50374.0 39683.6 41615.0 41952.0 42703.8 42838.8 40840.4 40947.8 41060.4 41673.0 41758.8 40248.4 41918.0 42590.1 42614.4 42634.0 35744.5 37726.2 37873.4 38147.8 38573.6 28476.6 28704.7 28903.7 29006.4 29312.6 20:20:45 INFO - PROCESS | 16769 | 20:20:45 INFO - PROCESS | 16769 | [#2] jquery.html Cycles:180 Average:29643.61 Median:12684.15 stddev:85381.21 (673.1%) stddev-sans-first:85592.47 20:20:45 INFO - PROCESS | 16769 | Values: 386.9 386.9 389.8 394.8 413.5 17783.4 19295.8 19570.3 19657.9 20377.9 17609.5 17886.4 18237.3 18269.4 18356.8 5475.7 5478.2 5604.1 5642.8 5678.4 5565.8 5568.9 5591.1 5607.4 5610.2 5403.6 5503.1 5527.9 5535.5 5570.9 5460.7 5476.9 5484.1 5531.4 5535.5 4715.0 4858.0 4936.6 4949.3 4965.4 22634.5 22709.2 22815.4 23074.5 23200.2 2293.8 2309.0 2384.9 2398.2 2475.1 14423.7 14648.2 14720.9 14763.3 15095.2 1892.9 1958.1 1997.0 2036.9 2050.8 78746.2 78808.2 80702.6 81794.2 82102.0 10242.5 10431.8 10659.0 11041.8 11217.6 14388.2 14458.3 14494.4 14494.5 14509.2 7769.0 7825.1 7889.7 7895.2 8042.4 7553.7 7555.1 7609.4 7705.4 7927.3 6267.3 6456.3 6516.3 6528.3 6592.2 1853.7 1855.0 1855.3 1861.9 1920.7 960.5 1078.5 1083.8 1122.0 1147.3 19063.3 19718.1 19924.6 19976.8 20236.6 1063.4 1067.3 1097.5 1107.7 1110.2 10924.9 11438.0 11491.5 11520.7 11534.1 509726.0 514378.0 522491.0 525089.0 526288.0 85298.6 85311.6 85625.6 86221.0 86714.6 1018.2 1034.2 1036.7 1038.1 1054.4 17363.0 17392.5 17565.2 17718.8 17891.6 39072.3 39544.4 39576.0 39743.4 40505.0 52869.0 58428.4 58867.0 60752.0 61087.0 7560.1 7686.8 7805.7 8194.3 8422.5 9358.1 12494.9 13370.7 13508.4 13520.7 11863.9 12015.9 12029.6 12165.9 12281.6 11346.5 11427.8 11552.4 11576.9 11876.6 6405.3 10092.5 11912.3 12203.7 12436.4 8468.4 8730.8 8769.7 8776.9 8897.2 10956.9 12126.5 12163.1 12285.3 12452.6 20:20:45 INFO - PROCESS | 16769 | 20:20:45 INFO - PROCESS | 16769 | [#3] mootools.html Cycles:180 Average:5614.51 Median:5024.20 stddev:3088.30 (61.5%) stddev-sans-first:3081.42 20:20:45 INFO - PROCESS | 16769 | Values: 1491.1 1519.3 1661.4 1782.9 1789.6 7387.6 7980.4 8182.3 8713.3 8738.0 7957.1 8166.8 8229.1 8231.1 8233.9 2270.3 2295.2 2304.7 2309.2 2313.9 2246.0 2278.4 2287.4 2289.3 2293.3 2244.8 2246.8 2269.1 2297.7 2298.4 2229.1 2236.7 2256.8 2259.6 2265.4 2211.8 2262.1 2264.3 2268.4 2270.8 8150.5 8193.1 8213.0 8226.3 8236.3 4880.0 5017.5 5018.4 5029.9 5048.1 3303.9 3396.5 3439.4 3559.4 3587.8 1081.4 1100.6 1116.7 1122.4 1139.2 11321.2 11328.8 11342.1 11372.5 11381.4 4484.2 4532.2 4641.7 4656.3 4680.6 9740.5 9826.7 9843.1 9853.5 9874.6 5057.3 5058.1 5101.8 5107.1 5108.6 4040.9 4529.7 4571.6 4657.9 4692.0 3941.6 3943.7 4044.8 4060.1 4080.4 1305.8 1306.1 1319.5 1337.0 1337.4 1004.2 1010.3 1011.4 1026.0 1035.5 5973.5 6009.8 6023.3 6062.2 6369.9 962.3 976.3 1019.3 1025.6 1035.4 4125.4 4163.4 4210.2 4232.2 4255.3 10351.9 10573.0 10579.0 10597.0 10637.9 10477.7 10552.8 10562.5 10570.4 10595.3 7584.5 7886.2 7910.8 7944.1 8121.9 5853.7 5906.6 5965.5 6042.5 6100.5 9484.5 9647.0 9711.4 9720.7 9724.9 9520.2 9652.1 9692.7 9801.6 9896.4 6745.2 7466.1 7518.1 7658.8 7674.8 8322.3 8343.5 8354.2 8384.4 8386.1 7100.2 7270.7 7364.1 7395.0 7518.7 7177.5 7230.2 7254.7 7275.4 7294.2 6730.1 6764.4 6799.6 6840.1 6848.5 5068.7 5188.1 5238.4 5302.1 5339.9 5092.7 5237.2 5291.3 5365.0 5401.2 20:20:45 INFO - PROCESS | 16769 | 20:20:45 INFO - PROCESS | 16769 | [#4] prototype.html Cycles:180 Average:4909.49 Median:5681.83 stddev:1481.07 (26.1%) stddev-sans-first:1444.73 20:20:45 INFO - PROCESS | 16769 | Values: 326.6 328.3 331.9 335.0 335.8 5646.7 5652.2 5676.2 5682.1 5699.4 5553.7 5556.9 5562.5 5597.9 5598.1 4052.4 4197.9 4282.5 4284.7 4304.6 4257.3 4263.4 4274.4 4283.1 4316.7 4247.0 4286.0 4287.2 4288.0 4306.7 4015.6 4271.0 4280.9 4286.4 4286.9 3719.7 3726.2 3737.5 3745.9 3752.8 5372.6 5385.8 5394.3 5403.2 5456.3 4607.6 4834.9 4836.8 4923.0 4944.1 5779.1 5791.0 5844.4 5872.9 5885.2 4074.2 4078.9 4081.0 4102.3 4105.9 5908.2 5973.8 5997.9 6003.2 6170.8 4134.3 4134.5 4141.3 4166.3 4197.7 4173.2 4196.8 4237.0 4241.4 4253.3 4692.9 4799.2 4799.6 4806.0 4815.8 5861.7 5866.7 5875.8 5892.8 5936.2 1444.4 1465.6 1472.1 1473.5 1477.5 918.4 931.7 945.7 957.3 995.6 5634.5 5657.3 5681.5 5682.3 5698.6 5890.8 5913.8 5916.9 5921.1 5950.4 5418.9 5577.4 5728.3 5749.7 5791.0 3177.8 3189.5 3190.9 3197.6 3220.5 6130.0 6184.7 6204.2 6252.3 6332.7 6047.0 6145.1 6179.8 6182.9 6192.7 6122.7 6268.5 6269.8 6321.0 6338.4 6021.2 6052.1 6052.7 6087.3 6101.0 5991.8 6008.2 6009.7 6031.5 6032.5 5983.6 6244.3 6276.4 6278.6 6282.7 4132.8 4150.2 4167.1 4170.6 4184.3 6061.6 6125.7 6166.5 6166.5 6168.8 5616.8 5895.8 5914.8 5941.3 5945.9 5860.2 5893.7 5912.0 5932.9 5949.3 5327.5 5749.4 5760.7 5787.6 5787.6 5919.7 5952.4 5964.4 5975.2 5975.7 5574.4 5709.7 5716.9 5732.8 5833.4 20:20:45 INFO - PROCESS | 16769 | 20:20:45 INFO - PROCESS | 16769 | [#5] yui.html Cycles:180 Average:16434.27 Median:4839.15 stddev:20539.25 (424.4%) stddev-sans-first:20563.43 20:20:45 INFO - PROCESS | 16769 | Values: 826.6 841.5 846.5 853.8 863.7 13305.7 13489.3 13503.5 13577.4 13672.7 14084.2 14248.0 14251.4 14258.9 14264.6 659.5 764.9 796.8 801.7 817.5 800.4 802.2 804.7 805.3 808.3 859.6 861.9 862.2 862.4 862.7 851.4 851.8 853.4 854.8 855.7 617.6 620.9 622.1 622.8 624.3 12872.5 12892.6 12916.9 12917.2 12932.9 13904.5 13984.0 14009.3 14063.7 14209.4 11838.2 11848.5 11971.9 12006.2 12559.5 3858.9 3905.5 3915.9 3931.3 4037.2 58170.7 59514.1 59977.4 60102.7 60152.7 10737.5 10954.9 10986.3 11042.9 11076.8 20519.9 20658.7 20740.1 20795.5 20876.9 8071.0 8266.0 8343.5 8397.9 8458.2 4714.7 4716.3 4797.4 4880.9 4932.1 3405.1 3489.5 3496.9 3504.2 3510.5 578.6 629.0 658.0 660.1 667.6 759.0 764.0 776.6 786.5 795.3 9359.4 9510.1 9622.8 9674.1 9685.5 659.0 687.9 793.3 794.3 809.2 4667.3 4685.9 4757.0 4892.4 4946.6 71467.3 74494.3 75229.6 76300.0 76380.6 64378.0 67550.7 67967.3 68086.7 68199.7 61411.4 61414.8 61833.7 62620.4 63238.4 9239.9 9319.9 9483.5 9573.5 9589.8 39455.8 39506.2 40103.0 40261.2 40925.0 52890.0 53308.0 53641.0 54117.0 55258.7 10950.9 11062.1 11304.6 11708.4 11715.3 12178.5 12236.2 12433.5 12688.2 13409.2 12670.9 12752.4 12885.7 13554.1 13642.7 12798.5 12852.0 12956.0 13331.3 13352.2 12423.9 12590.0 12591.2 12833.4 12837.6 10378.8 10703.5 10778.6 10806.9 10920.8 10762.4 10824.4 10925.6 10959.2 11185.3 20:20:45 INFO - PROCESS | 16769 | -------- Summary: end -------- 20:20:45 INFO - PROCESS | 16769 | 20:20:46 INFO - TEST-INFO | 16769: exit 0 20:20:46 INFO - TEST-OK | dromaeo_css | took 1110076ms 20:20:46 INFO - TEST-START | kraken 20:20:46 INFO - operating with platform_type : linux_ 20:20:46 INFO - Initialising browser for kraken test... 20:20:46 INFO - TEST-INFO | started process 17007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl_45GY/profile http://localhost:52845/getInfo.html) 20:20:50 INFO - PROCESS | 17007 | __metrics Screen width/height:1600/1200 20:20:50 INFO - PROCESS | 17007 | colorDepth:24 20:20:50 INFO - PROCESS | 17007 | Browser inner width/height: 1024/697 20:20:50 INFO - PROCESS | 17007 | __metrics 20:20:51 ERROR - PROCESS | 17007 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:20:51 INFO - TEST-INFO | 17007: exit 0 20:20:51 INFO - Browser initialized. 20:20:51 INFO - Running cycle 1/1 for kraken test... 20:20:51 INFO - TEST-INFO | started process 17127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl_45GY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:03 INFO - PROCESS | 17127 | RSS: Main: 166944768 20:21:03 INFO - PROCESS | 17127 | 20:21:06 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52845/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:06 INFO - PROCESS | 17127 | RSS: Main: 172277760 20:21:06 INFO - PROCESS | 17127 | 20:21:09 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52845/tests/kraken/driver.html?testName=audio-dft) 20:21:10 INFO - PROCESS | 17127 | RSS: Main: 171667456 20:21:10 INFO - PROCESS | 17127 | 20:21:13 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52845/tests/kraken/driver.html?testName=audio-fft) 20:21:13 INFO - PROCESS | 17127 | RSS: Main: 166555648 20:21:13 INFO - PROCESS | 17127 | 20:21:15 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52845/tests/kraken/driver.html?testName=audio-oscillator) 20:21:16 INFO - PROCESS | 17127 | RSS: Main: 167522304 20:21:16 INFO - PROCESS | 17127 | 20:21:18 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52845/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:21:19 INFO - PROCESS | 17127 | RSS: Main: 167653376 20:21:19 INFO - PROCESS | 17127 | 20:21:22 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52845/tests/kraken/driver.html?testName=imaging-darkroom) 20:21:23 INFO - PROCESS | 17127 | RSS: Main: 168329216 20:21:23 INFO - PROCESS | 17127 | 20:21:26 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52845/tests/kraken/driver.html?testName=imaging-desaturate) 20:21:27 INFO - PROCESS | 17127 | RSS: Main: 165986304 20:21:27 INFO - PROCESS | 17127 | 20:21:30 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52845/tests/kraken/driver.html?testName=json-parse-financial) 20:21:30 INFO - PROCESS | 17127 | RSS: Main: 167399424 20:21:30 INFO - PROCESS | 17127 | 20:21:32 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52845/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:21:32 INFO - PROCESS | 17127 | RSS: Main: 167432192 20:21:32 INFO - PROCESS | 17127 | 20:21:34 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52845/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:21:35 INFO - PROCESS | 17127 | RSS: Main: 167518208 20:21:35 INFO - PROCESS | 17127 | 20:21:37 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52845/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:21:38 INFO - PROCESS | 17127 | RSS: Main: 167903232 20:21:38 INFO - PROCESS | 17127 | 20:21:40 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:21:41 INFO - PROCESS | 17127 | RSS: Main: 168378368 20:21:41 INFO - PROCESS | 17127 | 20:21:43 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:21:44 INFO - PROCESS | 17127 | RSS: Main: 167809024 20:21:44 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | Cycle 1(1): loaded http://localhost:52845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52845/tests/kraken/driver.html?testName=ai-astar) 20:21:46 INFO - PROCESS | 17127 | RSS: Main: 168579072 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | __start_tp_report 20:21:46 INFO - PROCESS | 17127 | _x_x_mozilla_page_load 20:21:46 INFO - PROCESS | 17127 | _x_x_mozilla_page_load_details 20:21:46 INFO - PROCESS | 17127 | |i|pagename|runs| 20:21:46 INFO - PROCESS | 17127 | |0;ai-astar;111;107;110;111;111;110;112;111;110;110 20:21:46 INFO - PROCESS | 17127 | |1;audio-beat-detection;164;125;152;182;127;162;157;128;183;124 20:21:46 INFO - PROCESS | 17127 | |2;audio-dft;162;161;163;161;162;167;166;160;164;163 20:21:46 INFO - PROCESS | 17127 | |3;audio-fft;75;75;76;157;75;74;75;77;168;76 20:21:46 INFO - PROCESS | 17127 | |4;audio-oscillator;84;84;148;84;83;85;151;82;83;146 20:21:46 INFO - PROCESS | 17127 | |5;imaging-gaussian-blur;118;118;118;117;118;119;119;117;118;117 20:21:46 INFO - PROCESS | 17127 | |6;imaging-darkroom;145;146;147;147;149;147;147;146;146;147 20:21:46 INFO - PROCESS | 17127 | |7;imaging-desaturate;95;96;95;95;96;95;95;95;95;95 20:21:46 INFO - PROCESS | 17127 | |8;json-parse-financial;55;55;57;54;55;56;54;53;55;54 20:21:46 INFO - PROCESS | 17127 | |9;json-stringify-tinderbox;63;62;63;62;62;62;62;61;63;62 20:21:46 INFO - PROCESS | 17127 | |10;stanford-crypto-aes;79;83;78;80;78;82;80;81;107;86 20:21:46 INFO - PROCESS | 17127 | |11;stanford-crypto-ccm;120;119;151;119;132;122;120;131;127;130 20:21:46 INFO - PROCESS | 17127 | |12;stanford-crypto-pbkdf2;166;158;161;164;159;155;158;158;156;160 20:21:46 INFO - PROCESS | 17127 | |13;stanford-crypto-sha256-iterative;63;64;65;64;65;63;66;62;63;63 20:21:46 INFO - PROCESS | 17127 | __end_tp_report 20:21:46 INFO - PROCESS | 17127 | __start_cc_report 20:21:46 INFO - PROCESS | 17127 | _x_x_mozilla_cycle_collect,853 20:21:46 INFO - PROCESS | 17127 | __end_cc_report 20:21:46 INFO - PROCESS | 17127 | __startTimestamp1464664906440__endTimestamp 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | ------- Summary: start ------- 20:21:46 INFO - PROCESS | 17127 | Number of tests: 14 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.34 (1.2%) stddev-sans-first:1.39 20:21:46 INFO - PROCESS | 17127 | Values: 111.0 107.0 110.0 111.0 111.0 110.0 112.0 111.0 110.0 110.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:159.50 stddev:23.14 (14.5%) stddev-sans-first:24.01 20:21:46 INFO - PROCESS | 17127 | Values: 164.0 125.0 152.0 182.0 127.0 162.0 157.0 128.0 183.0 124.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.23 (1.4%) stddev-sans-first:2.35 20:21:46 INFO - PROCESS | 17127 | Values: 162.0 161.0 163.0 161.0 162.0 167.0 166.0 160.0 164.0 163.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:36.84 (49.1%) stddev-sans-first:38.50 20:21:46 INFO - PROCESS | 17127 | Values: 75.0 75.0 76.0 157.0 75.0 74.0 75.0 77.0 168.0 76.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:83.50 stddev:31.32 (37.5%) stddev-sans-first:32.45 20:21:46 INFO - PROCESS | 17127 | Values: 84.0 84.0 148.0 84.0 83.0 85.0 151.0 82.0 83.0 146.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 20:21:46 INFO - PROCESS | 17127 | Values: 118.0 118.0 118.0 117.0 118.0 119.0 119.0 117.0 118.0 117.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 20:21:46 INFO - PROCESS | 17127 | Values: 145.0 146.0 147.0 147.0 149.0 147.0 147.0 146.0 146.0 147.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:21:46 INFO - PROCESS | 17127 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.14 (2.1%) stddev-sans-first:1.20 20:21:46 INFO - PROCESS | 17127 | Values: 55.0 55.0 57.0 54.0 55.0 56.0 54.0 53.0 55.0 54.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 20:21:46 INFO - PROCESS | 17127 | Values: 63.0 62.0 63.0 62.0 62.0 62.0 62.0 61.0 63.0 62.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:80.50 stddev:8.64 (10.7%) stddev-sans-first:9.02 20:21:46 INFO - PROCESS | 17127 | Values: 79.0 83.0 78.0 80.0 78.0 82.0 80.0 81.0 107.0 86.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:128.50 stddev:9.87 (7.7%) stddev-sans-first:10.13 20:21:46 INFO - PROCESS | 17127 | Values: 120.0 119.0 151.0 119.0 132.0 122.0 120.0 131.0 127.0 130.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.50 stddev:3.41 (2.1%) stddev-sans-first:2.68 20:21:46 INFO - PROCESS | 17127 | Values: 166.0 158.0 161.0 164.0 159.0 155.0 158.0 158.0 156.0 160.0 20:21:46 INFO - PROCESS | 17127 | 20:21:46 INFO - PROCESS | 17127 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 20:21:46 INFO - PROCESS | 17127 | Values: 63.0 64.0 65.0 64.0 65.0 63.0 66.0 62.0 63.0 63.0 20:21:46 INFO - PROCESS | 17127 | -------- Summary: end -------- 20:21:46 INFO - PROCESS | 17127 | 20:21:47 INFO - TEST-INFO | 17127: exit 0 20:21:47 INFO - TEST-OK | kraken | took 61341ms 20:21:47 INFO - SUITE-END | took 1171s 20:21:47 INFO - Completed test suite (00:19:31) 20:21:47 INFO - javascript benchmark 20:21:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7254.961857158448, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.5226739855325, 3125.7186853183216, 3133.8746450141994, 3164.9208769780753, 3178.014815407224, 5354.196870469432, 5357.892842143155, 5364.034473794715, 5410.242566040757, 5428.61999660023, 5274.208868669702, 5375.43557926417, 5442.510174084332, 5450.100733378988, 5464.0, 4913.656044076907, 4928.334674818907, 4974.452810190876, 5083.212102124176, 5133.281340612299, 4925.236588328797, 5063.721495317756, 5076.74616269185, 5109.948900511003, 5111.003354345904, 4882.218844984785, 4923.679960802537, 4949.084419382426, 4992.725400102993, 4995.825146119886, 4988.052270068712, 4992.151334273146, 4994.800207991676, 4995.800167993276, 5046.369203849519, 4962.578180854632, 4963.255511673242, 4963.801447942078, 4982.17794063979, 4997.0505603935135, 5098.592112631018, 5227.18978558324, 5284.894302113975, 5292.497212764782, 5329.0, 5822.301323841124, 5822.7088645567555, 5825.592208545403, 5826.650400975913, 5828.3297420796725, 5641.407652196543, 5863.355030946593, 5869.090291004901, 5871.970640146815, 5884.617499862496, 5418.864528386783, 5431.293931788842, 5459.153831156177, 5493.505584497454, 5502.614816962814, 5988.431099045583, 5990.041593345044, 5991.910121348184, 5993.250843644544, 5998.490128339053, 5571.4150014248735, 5580.135079062752, 5742.827715168552, 5752.07966725322, 5760.308762948389, 5689.943100569024, 5742.08126699726, 5742.08126699726, 5743.56923230751, 5790.218320526759, 5558.805441809517, 5667.574931880125, 5693.373728889819, 5726.026575482178, 5727.5131613812455, 5763.077907534858, 5781.971090144522, 5786.508146807484, 5823.88352232953, 5861.6189947653265, 4407.669424793154, 4438.7114837535455, 4440.089781594766, 4449.087936972913, 4466.531014243523, 3886.514185726784, 3900.258950799339, 3919.666828319625, 3941.52701675795, 4009.558948515661, 5565.916511252334, 5576.86057848557, 5588.888222235532, 5591.0, 5631.380548139783, 5812.593118481665, 5855.736491857877, 5859.560532960045, 5868.589198756046, 5874.970625146932, 5412.512873841373, 5521.475459831309, 5542.722863856791, 5555.333359996826, 5569.832905012775, 5003.199488081889, 5029.1443690691885, 5029.1450453423, 5029.170186919117, 5042.697438153723, 6036.215292012098, 6038.969805150946, 6041.305249896318, 6041.848953776191, 6050.152978583002, 5705.115707065412, 5784.248047753765, 5826.679532625577, 5827.067669172912, 5846.298444186725, 5961.701914904151, 6017.578769486269, 6021.819345419644, 6024.849378765566, 6025.246844144482, 5554.97222513901, 5700.173474846207, 5706.144078388275, 5707.514861236841, 5709.800156994485, 5805.158252053513, 5832.0, 5853.09277062056, 5883.882322353615, 5889.234399528034, 5668.291463567054, 5697.259356283656, 5716.485516303553, 5724.112762521816, 5725.6850873202375, 5465.699386533779, 5514.365847927379, 5702.6863522506665, 5714.771409143587, 5722.055860782924, 5439.129739241703, 5443.020256353736, 5477.616566840283, 5484.808031718871, 5559.19391688211, 5605.383407825055, 5716.056850619768, 5729.169270455844, 5730.169125476866, 5752.712364381848, 5441.918371224514, 5622.859428514156, 5629.324481062299, 5632.690202038927, 5639.54883609302], "value": 5353.327338265558, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.2368168744007, 645.1419611916152, 651.1014799576584, 660.4353277947356, 661.8014595621312, 42674.78662606687, 43725.34411983823, 43933.340999884946, 44021.339679904784, 48006.279905801355, 46465.0, 46807.29789053158, 47135.76432117843, 47179.0, 47255.52744472554, 8752.299816014704, 8985.14641109097, 8994.595243214038, 9013.18881300686, 9039.59321830516, 8863.157999989991, 8922.509261990588, 8928.821423571524, 8942.41874278173, 8974.86537701935, 8962.507062111614, 8970.551472426385, 9025.097490250955, 9036.728898133033, 9055.094490550959, 8974.910250897505, 9004.144606262395, 9005.459672419644, 9024.278057755397, 9048.683296084606, 8924.643014279422, 8986.146316100025, 9009.054049324857, 9012.27901767857, 9028.052054534244, 40373.394399084034, 40435.191296174205, 40554.0, 40998.0, 41047.7947610263, 3663.285659296438, 3689.9262014759556, 3692.5015122958325, 3966.127451960564, 3995.7402768819934, 32482.0, 32927.83536082304, 32928.341433171445, 32932.176695582566, 33760.0, 4392.0776636906285, 4444.422452695767, 4449.977750111261, 4569.908601827978, 4605.608523275526, 353616.0, 354086.0, 354986.2250688756, 355552.0, 356564.9999999974, 60315.69842150849, 60570.0, 60850.69574652187, 61057.0, 61404.385956139864, 35103.29793404118, 63789.36210637834, 64412.0, 64449.355506444335, 64670.353296466434, 16330.67338653244, 17137.0, 17238.913805430893, 17296.135193240287, 17312.0, 12974.0, 13099.738005239842, 13118.737625247633, 13155.802662960063, 13175.275359855108, 19664.60670786605, 19989.700154497696, 20006.0, 20065.899670501847, 20127.899360503103, 7134.571925684476, 7307.3423391894985, 7459.0, 7474.7757567273065, 7549.131849837229, 990.6582229130938, 1073.9624113156, 1127.1264769803468, 1155.8035134027236, 1175.735459521601, 32533.0, 33251.33497330088, 33323.3335333292, 33404.66595334064, 33473.49789753155, 1148.833419154218, 1173.137743758337, 1239.6838806104565, 1256.8931640810633, 1297.9221246725226, 17108.315667373416, 17414.738778918327, 17555.648887022187, 17564.121793910253, 17673.20470578827, 549749.0, 558311.0, 560863.5654573853, 562045.0, 564249.0, 59129.0, 59137.40862591319, 59649.70175149183, 59732.402675972684, 59812.70093649591, 1337.3647517429142, 1381.7650999330137, 1394.3446580107536, 1401.6776141487514, 1410.0200360749182, 31347.373052538365, 31494.685053149176, 31700.0, 32345.676543234265, 32598.837005814818, 51875.74062129665, 52019.2197117036, 52115.21827172671, 52469.21296180637, 52674.736626316626, 450223.0, 458075.0, 460258.0, 460409.0, 460435.0, 28239.43521129607, 28347.716522834507, 28637.14088577346, 28638.570421443277, 28664.283392915346, 49100.0, 49282.0, 49910.75044624753, 50103.0, 50374.0, 39683.60316396914, 41615.0, 41952.0, 42703.78648106739, 42838.78580607202, 40840.38739418852, 40947.795261024694, 41060.38409423801, 41673.0, 41758.79120604499, 40248.3962740565, 41918.0, 42590.14819703527, 42614.36078458764, 42634.0, 35744.463833042006, 37726.245475089796, 37873.43189852099, 38147.809260953516, 38573.614263857, 28476.572851407658, 28704.712952870203, 28903.7109628901, 29006.419871602873, 29312.560311594916], "value": 20684.35062587608, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.93035253654347, 386.94776205212287, 389.791461568061, 394.8440366055408, 413.495535446755, 17783.37758178464, 19295.807041929576, 19570.31503897364, 19657.901710491446, 20377.898110509464, 17609.471715848515, 17886.373976910778, 18237.270509179616, 18269.36057237997, 18356.816431835712, 5475.698836563987, 5478.205660179272, 5604.075327570946, 5642.802501912434, 5678.375378708339, 5565.805196818113, 5568.9443105569035, 5591.1054231323, 5607.355154157283, 5610.24261724666, 5403.621746477748, 5503.064479038573, 5527.944720552803, 5535.474129957668, 5570.888582228353, 5460.672359658413, 5476.91784623231, 5484.067708489566, 5531.419200983899, 5535.474129957668, 4715.0, 4857.951420485785, 4936.605071594264, 4949.331840201563, 4965.379327584052, 22634.547309053727, 22709.205177818698, 22815.42961425961, 23074.538509229722, 23200.187993420317, 2293.7591552886875, 2308.9769102309097, 2384.892679829412, 2398.2445529658103, 2475.084218839023, 14423.711525769426, 14648.194349310783, 14720.852791472056, 14763.26183690822, 15095.24523773818, 1892.9175164682733, 1958.109060377539, 1997.0, 2036.8879711615855, 2050.764162121345, 78746.21253787504, 78808.21191788066, 80702.59648701777, 81794.18205817926, 82102.0, 10242.53908574116, 10431.791364172674, 10658.987396197348, 11041.779164416666, 11217.551297948154, 14388.20864852443, 14458.277086145861, 14494.420223191166, 14494.492692755703, 14509.201993890227, 7769.028871391076, 7825.100113486908, 7889.723859664884, 7895.210478952059, 8042.437029407885, 7553.697852085965, 7555.09338879338, 7609.381756370593, 7705.4220933430215, 7927.286544211049, 6267.341929097379, 6456.257530383972, 6516.2506311773805, 6528.347165283529, 6592.241892182365, 1853.6634058694297, 1854.9907250463662, 1855.3135339924045, 1861.9162137703836, 1920.6542822291842, 960.481340076351, 1078.4823284823328, 1083.7778255457613, 1122.0014187373245, 1147.3230793831679, 19063.332783352515, 19718.112684929212, 19924.60150796976, 19976.800231997495, 20236.59526809485, 1063.4310643805682, 1067.295584913953, 1097.5280629329466, 1107.6953837694698, 1110.2006555280186, 10924.945375273232, 11438.0, 11491.482883270273, 11520.711982200344, 11534.077273818075, 509726.0, 514378.0, 522491.0, 525089.0, 526288.0, 85298.5735071333, 85311.57344213239, 85625.57187214024, 86221.0, 86714.56642716873, 1018.1651046142092, 1034.1933292032227, 1036.7045392063226, 1038.1487180511908, 1054.3989925742408, 17363.0, 17392.47822565325, 17565.209565569836, 17718.82281177172, 17891.642167156322, 39072.27293131781, 39544.40683389809, 39576.0, 39743.40384894171, 40505.0, 52869.0, 58428.4157158423, 58867.0, 60752.0, 61087.0, 7560.130584982578, 7686.846263074595, 7805.726799561988, 8194.303484203909, 8422.452540584842, 9358.066685124328, 12494.937525312314, 13370.665733356744, 13508.44652864933, 13520.72958540804, 11863.940680296544, 12015.939920300343, 12029.578964736193, 12165.939170304091, 12281.631551053482, 11346.546138154712, 11427.771444571228, 11552.42237888119, 11576.88423115758, 11876.55302653805, 6405.327440618668, 10092.495375231356, 11912.344821034927, 12203.69490762738, 12436.378181090728, 8468.3648726347, 8730.781730456536, 8769.736907892773, 8776.868346974672, 8897.199252067345, 10956.945215273872, 12126.454309556268, 12163.148579599343, 12285.324307163191, 12452.564160254347], "value": 9290.465439723346, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.0755331694347, 1519.3239008641156, 1661.3520726916504, 1782.8841125326844, 1789.6241789224262, 7387.556746595194, 7980.401469889753, 8182.263596276342, 8713.259372953298, 8737.95631021844, 7957.124716281219, 8166.795830104235, 8229.135940726228, 8231.053428855683, 8233.876491852627, 2270.3302525754943, 2295.2081531871477, 2304.72343318802, 2309.2494939144763, 2313.8958746856347, 2245.9663105053355, 2278.362058623588, 2287.4281429642588, 2289.2559918026623, 2293.334932869466, 2244.7755224477587, 2246.8202543796538, 2269.126386341254, 2297.6783250344965, 2298.367948814081, 2229.1194977983687, 2236.7204099487562, 2256.7856053674873, 2259.6497542880797, 2265.4223173090923, 2211.7677643847487, 2262.1403866530777, 2264.3320220534815, 2268.410213344542, 2270.7956283934527, 8150.510969341858, 8193.09875913649, 8212.958935205286, 8226.300764435031, 8236.341092712568, 4879.951200487985, 5017.473165317662, 5018.447970723218, 5029.949700502984, 5048.091343558158, 3303.9174020649434, 3396.5225127069803, 3439.398105331582, 3559.4482855157235, 3587.820608969541, 1081.3511892864296, 1100.5982816272003, 1116.6650004998548, 1122.4275619434065, 1139.2196345503357, 11321.20751547392, 11328.830067548912, 11342.092632589372, 11372.48823802931, 11381.374024428653, 4484.2376795944765, 4532.184206842734, 4641.721496710141, 4656.278276867091, 4680.602148817388, 9740.46427446483, 9826.65606703762, 9843.064908833649, 9853.50732463374, 9874.605015799287, 5057.342545469065, 5058.114829904752, 5101.846944591668, 5107.080725469377, 5108.56577190943, 4040.898977525527, 4529.728216306966, 4571.611413029929, 4657.858824587997, 4691.953080469151, 3941.5664276929515, 3943.684505239574, 4044.8179831907637, 4060.147369052473, 4080.449139366207, 1305.7845455499926, 1306.0596370613334, 1319.5249710104354, 1336.9732605347838, 1337.3981708231336, 1004.1765752083221, 1010.3382284603597, 1011.4285428732743, 1025.9538320775582, 1035.471909326234, 5973.462388385066, 6009.849753756191, 6023.27720673522, 6062.151298818169, 6369.872602547923, 962.2686758063782, 976.2629214942673, 1019.3425240719695, 1025.600015993748, 1035.3942943378058, 4125.422440858282, 4163.39630753539, 4210.200061988213, 4232.153569286155, 4255.276602977501, 10351.896481035094, 10573.0, 10579.0, 10597.0, 10637.946810266054, 10477.738056548647, 10552.788944221225, 10562.524686389132, 10570.365778053341, 10595.311304765166, 7584.469087163846, 7886.211378862183, 7910.762677119696, 7944.126146123922, 8121.918780812116, 5853.736581853742, 5906.557008224315, 5965.4788029052315, 6042.456178943916, 6100.511959043177, 9484.525773711424, 9646.951765241129, 9711.36876103051, 9720.659776907774, 9724.854127187957, 9520.190783783455, 9652.083052110038, 9692.660756873758, 9801.558929848032, 9896.356736812084, 6745.156855393076, 7466.141393739572, 7518.135414427192, 7658.8085297868, 7674.8081297968, 8322.334213262804, 8343.45767525109, 8354.16458354184, 8384.413091083565, 8386.119457457124, 7100.218975912749, 7270.6728197230195, 7364.079490063742, 7394.963025185055, 7518.661660225413, 7177.497575169688, 7230.240824713329, 7254.746083887038, 7275.381592564691, 7294.161171465349, 6730.125083739278, 6764.425023872829, 6799.626020568916, 6840.076589660531, 6848.486363522656, 5068.701070458528, 5188.147033789243, 5238.4237733850005, 5302.072137375867, 5339.866503337447, 5092.670891490927, 5237.16205407133, 5291.3121294231505, 5365.0, 5401.2168235606405], "value": 4557.913678498383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.60317713977514, 328.2745133255505, 331.8921350561067, 334.97152742016925, 335.7683198592971, 5646.729485865683, 5652.180433837097, 5676.176954341618, 5682.119271512912, 5699.430056994299, 5553.666779993193, 5556.9444305556935, 5562.471565201299, 5597.888042239153, 5598.144946077499, 4052.3516237402023, 4197.9370309445385, 4282.464691913511, 4284.6786491013145, 4304.569543045702, 4257.318828987362, 4263.403123562688, 4274.358846173083, 4283.100548884738, 4316.6546676265825, 4247.0, 4285.9571404286025, 4287.20686672965, 4288.0, 4306.676999225055, 4015.558288588253, 4270.996315865769, 4280.850170244058, 4286.378475121106, 4286.892827679333, 3719.702423806089, 3726.2361215950664, 3737.495438115874, 3745.906352341186, 3752.8123593820474, 5372.57019438444, 5385.7576409061685, 5394.298741163623, 5403.243545903577, 5456.317960254968, 4607.631389488833, 4834.854954351375, 4836.831875121801, 4923.0, 4944.058285320229, 5779.133130030487, 5790.971045144747, 5844.44477774615, 5872.941270587282, 5885.205497257858, 4074.185162967389, 4078.9184216315803, 4080.9795951020055, 4102.297546518192, 4105.856295029689, 5908.202392676976, 5973.761049558012, 5997.940020599782, 6003.199040287896, 6170.84572885677, 4134.297169481196, 4134.503859536875, 4141.26067051839, 4166.312558427886, 4197.706160568731, 4173.1862286854375, 4196.769177695195, 4237.0466645005245, 4241.427407300037, 4253.298205796071, 4692.929606055912, 4799.232122860326, 4799.592034677092, 4805.975970120127, 4815.807367705253, 5861.681121747572, 5866.70666466675, 5875.764969401176, 5892.823215303548, 5936.1986131871645, 1444.3500424808667, 1465.5969608357573, 1472.0873058703457, 1473.4842805018159, 1477.5050358129931, 918.4397517514311, 931.6552875436132, 945.664289177346, 957.2820384711466, 995.5719040812376, 5634.464725851038, 5657.349404818417, 5681.545476361881, 5682.272509195526, 5698.572607054488, 5890.823275301748, 5913.752773945959, 5916.911246331309, 5921.111833225051, 5950.375210602911, 5418.8916221675345, 5577.386487486373, 5728.312602487728, 5749.712514374264, 5790.971045144832, 3177.8252196129433, 3189.5215717642077, 3190.941842511567, 3197.6322722886703, 3220.5330227117406, 6130.0, 6184.690765461709, 6204.193454850931, 6252.343503932113, 6332.746690132343, 6047.034713718059, 6145.108959200891, 6179.806168810008, 6182.907256391068, 6192.721327540272, 6122.673384114098, 6268.49852011838, 6269.843253918689, 6321.0, 6338.366163383625, 6021.157038014769, 6052.093590518973, 6052.6973651316375, 6087.2999605044215, 6101.0, 5991.760329586942, 6008.218931538872, 6009.729562169626, 6031.547633927561, 6032.4570788629235, 5983.551233657406, 6244.2819075806865, 6276.372362763687, 6278.591891527036, 6282.748690052346, 4132.752034877917, 4150.232207041707, 4167.124903770242, 4170.582941705805, 4184.288670925889, 6061.605995610271, 6125.663088530174, 6166.475849552839, 6166.537509686881, 6168.753249869955, 5616.831495055155, 5895.793647222326, 5914.792982245773, 5941.346451890375, 5945.851353716192, 5860.15027820955, 5893.728980415739, 5911.96540605401, 5932.940670593412, 5949.286085669747, 5327.520523152934, 5749.367569567428, 5760.711964401847, 5787.565932554991, 5787.594868359174, 5919.733611987557, 5952.404759524013, 5964.373740757332, 5975.193348897843, 5975.701214939322, 5574.442555744393, 5709.65742055478, 5716.885662286814, 5732.796112816355, 5833.358330583717], "value": 4429.914148538626, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.6114925984787, 841.4908980067063, 846.5005646668468, 853.8121613245091, 863.6674880171134, 13305.733885322288, 13489.258090805002, 13503.527376541811, 13577.389017494212, 13672.726545469084, 14084.154950702965, 14248.0, 14251.358688859, 14258.928705356459, 14264.643383915407, 659.4757168051386, 764.9235076492362, 796.8007998000486, 801.7153910361825, 817.480899628734, 800.4116974024116, 802.2498963469146, 804.7183485779989, 805.255138996426, 808.296781799832, 859.5616235719797, 861.8707193920899, 862.1507814802414, 862.4264863865521, 862.7325529085972, 851.43379652531, 851.7955690634234, 853.3855623950745, 854.8290341931577, 855.683397143061, 617.6417677746941, 620.9316975132732, 622.1197006236171, 622.757124721359, 624.3475568031419, 12872.485100595964, 12892.613221603273, 12916.870831291755, 12917.22496650204, 12932.87067129326, 13904.51334203298, 13984.0, 14009.29953502331, 14063.718725625431, 14209.431622735077, 11838.230515016496, 11848.50434704537, 11971.880281197251, 12006.159568830186, 12559.497620095186, 3858.884233473, 3905.453236546886, 3915.882523524299, 3931.2923673738715, 4037.1521980384155, 58170.70914645442, 59514.10728839114, 59977.40022599762, 60102.69948650272, 60152.69923650398, 10737.51681174349, 10954.890451095547, 10986.340819550693, 11042.944785276022, 11076.833847492133, 20519.897400512902, 20658.690119648218, 20740.06669699867, 20795.480112996993, 20876.895615521826, 8070.959645201737, 8266.0, 8343.45767525109, 8397.874031889527, 8458.238758511763, 4714.717116972924, 4716.316134160527, 4797.40032495938, 4880.902381952341, 4932.062908047459, 3405.0976491229844, 3489.4940233665975, 3496.930061398758, 3504.15900183954, 3510.526078979356, 578.6325683191204, 628.9779857704958, 658.0195508692015, 660.1220376898809, 667.5894324990096, 758.9848203035908, 763.9847203055908, 776.5690042026729, 786.5280831501053, 795.3478147918651, 9359.391639543408, 9510.144087032062, 9622.759431014281, 9674.129328360481, 9685.467299298465, 658.9505787065893, 687.8796210663114, 793.2860425616991, 794.3406972213049, 809.1665584448028, 4667.346571479996, 4685.8594242172785, 4757.0, 4892.363992680928, 4946.579540739078, 71467.2853271471, 74494.25505744982, 75229.62385188148, 76300.0, 76380.61809690917, 64378.0, 67550.66224668846, 67967.32032679609, 68086.65956670285, 68199.65900170467, 61411.38588614146, 61414.77170456566, 61833.69083154645, 62620.37379626236, 63238.36761632417, 9239.907600924174, 9319.906800931903, 9483.52582370865, 9573.473458959825, 9589.760255993377, 39455.80272098621, 39506.209875802895, 40103.0, 40261.1947761049, 40925.0, 52890.0, 53308.0, 53641.0, 54117.0, 55258.72370638282, 10950.945245273722, 11062.115030797357, 11304.604338848101, 11708.356040417859, 11715.297082175097, 12178.538575371012, 12236.204646698292, 12433.502659893864, 12688.17526860751, 13409.195448273134, 12670.87329126697, 12752.362381881054, 12885.677858053623, 13554.051216414757, 13642.658933526343, 12798.488060477477, 12851.971842252784, 12956.0, 13331.266780327174, 13352.198868067948, 12423.875761242272, 12590.0, 12591.24452532851, 12833.358332083546, 12837.550685725955, 10378.792424151627, 10703.464826758787, 10778.568857245622, 10806.945965270123, 10920.78158436811, 10762.354258744188, 10824.350538967687, 10925.562977480811, 10959.178061645567, 11185.272957257752], "value": 7019.422040166924, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 110.0, 111.0, 111.0, 110.0, 112.0, 111.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 125.0, 152.0, 182.0, 127.0, 162.0, 157.0, 128.0, 183.0, 124.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 161.0, 162.0, 167.0, 166.0, 160.0, 164.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 157.0, 75.0, 74.0, 75.0, 77.0, 168.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 148.0, 84.0, 83.0, 85.0, 151.0, 82.0, 83.0, 146.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 119.0, 119.0, 117.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 147.0, 149.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 54.0, 55.0, 56.0, 54.0, 53.0, 55.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 61.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 78.0, 80.0, 78.0, 82.0, 80.0, 81.0, 107.0, 86.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 151.0, 119.0, 132.0, 122.0, 120.0, 131.0, 127.0, 130.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 158.0, 161.0, 164.0, 159.0, 155.0, 158.0, 158.0, 156.0, 160.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 65.0, 63.0, 66.0, 62.0, 63.0, 63.0], "value": 63.8, "unit": "score"}]}]} 20:21:47 INFO - Return code: 0 20:21:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:21:47 ERROR - # TBPL SUCCESS # 20:21:47 INFO - Running post-action listener: _resource_record_post_action 20:21:47 INFO - ##### 20:21:47 INFO - ##### Finished run-tests step (success) 20:21:47 INFO - ##### 20:21:47 INFO - Running post-run listener: _resource_record_post_run 20:21:47 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548802560; Read time: 16; Write time: 564468 20:21:47 INFO - TinderboxPrint: CPU usage
13.4% 20:21:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:21:47 INFO - TinderboxPrint: I/O write bytes / time
548,802,560 / 564,468 20:21:47 INFO - TinderboxPrint: CPU idle
8,210.1 (86.5%) 20:21:47 INFO - TinderboxPrint: CPU user
1,220.5 (12.9%) 20:21:47 INFO - TinderboxPrint: Swap in / out
0 / 0 20:21:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 170233856; Read time: 0; Write time: 259952 20:21:47 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291827712; Read time: 16; Write time: 265616 20:21:48 INFO - Running post-run listener: _upload_blobber_files 20:21:48 INFO - Blob upload gear active. 20:21:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:21:48 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:21:48 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:21:48 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:21:48 INFO - (blobuploader) - INFO - Open directory for files ... 20:21:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:21:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:49 INFO - (blobuploader) - INFO - Done attempting. 20:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:21:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:53 INFO - (blobuploader) - INFO - Done attempting. 20:21:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:21:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:21:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:54 INFO - (blobuploader) - INFO - Done attempting. 20:21:54 INFO - (blobuploader) - INFO - Iteration through files over. 20:21:54 INFO - Return code: 0 20:21:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:21:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:21:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d2b627bf83cc4d4892ac46f372d4c6c1c65975b8e3b595efbd4c08847a1ae6d376fb34b627455d7379b77d56b143c87b285746c2bbc0d376accfe63d25ff63b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/387748b61365d892bdc6e6d94297ab9d61bb8e070a580f8089a9900e7e3fe69fb7d9e62676ae33876250cf66b2a28abb648710ff4371a3ac36f6cc4c6c35d4e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad960b00107fb3fc09abcd99746a2c9bfe530647485203b25d2b74eaf131d0f5fba36c0b94b19a0a969b49e6805be16b4b643701ce80064b988eb6caa3465ec2"} 20:21:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:21:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:21:54 INFO - Contents: 20:21:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d2b627bf83cc4d4892ac46f372d4c6c1c65975b8e3b595efbd4c08847a1ae6d376fb34b627455d7379b77d56b143c87b285746c2bbc0d376accfe63d25ff63b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/387748b61365d892bdc6e6d94297ab9d61bb8e070a580f8089a9900e7e3fe69fb7d9e62676ae33876250cf66b2a28abb648710ff4371a3ac36f6cc4c6c35d4e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad960b00107fb3fc09abcd99746a2c9bfe530647485203b25d2b74eaf131d0f5fba36c0b94b19a0a969b49e6805be16b4b643701ce80064b988eb6caa3465ec2"} 20:21:54 INFO - Running post-run listener: copy_logs_to_upload_dir 20:21:54 INFO - Copying logs to upload dir... 20:21:54 INFO - mkdir: /builds/slave/test/build/upload/logs 20:21:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.186387 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 20:21:54.017461) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 20:21:54.020961) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444 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/7d2b627bf83cc4d4892ac46f372d4c6c1c65975b8e3b595efbd4c08847a1ae6d376fb34b627455d7379b77d56b143c87b285746c2bbc0d376accfe63d25ff63b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/387748b61365d892bdc6e6d94297ab9d61bb8e070a580f8089a9900e7e3fe69fb7d9e62676ae33876250cf66b2a28abb648710ff4371a3ac36f6cc4c6c35d4e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad960b00107fb3fc09abcd99746a2c9bfe530647485203b25d2b74eaf131d0f5fba36c0b94b19a0a969b49e6805be16b4b643701ce80064b988eb6caa3465ec2"} build_url:https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/euzgjpgLQaOaunvU0C2-0g/artifacts/public/build/firefox-49.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/7d2b627bf83cc4d4892ac46f372d4c6c1c65975b8e3b595efbd4c08847a1ae6d376fb34b627455d7379b77d56b143c87b285746c2bbc0d376accfe63d25ff63b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/387748b61365d892bdc6e6d94297ab9d61bb8e070a580f8089a9900e7e3fe69fb7d9e62676ae33876250cf66b2a28abb648710ff4371a3ac36f6cc4c6c35d4e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad960b00107fb3fc09abcd99746a2c9bfe530647485203b25d2b74eaf131d0f5fba36c0b94b19a0a969b49e6805be16b4b643701ce80064b988eb6caa3465ec2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 20:21:54.046663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:21:54.047029) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1464662698.184294-837353444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 20:21:54.133103) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 20:21:54.133780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 20:21:54.134426) ========= ========= Total master_lag: 0.20 =========