builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1463400348.89 results: success (0) buildid: 20160516023002 builduid: 70f2d249bc9f421eb856f88c10d290d5 revision: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:48.886517) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:48.886892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:48.887155) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:48.911180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:48.911429) ========= 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=aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 05:05:49-- 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% 224M=0s 2016-05-16 05:05:49 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122934 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:49.047882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:49.048187) ========= 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=aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021061 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:49.097122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 05:05:49.097461) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 --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 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 --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=aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 05:05:49,483 truncating revision to first 12 chars 2016-05-16 05:05:49,483 Setting DEBUG logging. 2016-05-16 05:05:49,483 attempt 1/10 2016-05-16 05:05:49,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0c29ad917ac3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 05:05:50,767 unpacking tar archive at: fx-team-0c29ad917ac3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.573686 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 05:05:50.684819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:50.685128) ========= script_repo_revision: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:50.685642) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:50.685922) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 05:05:50.694621) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-16 05:05:50.694891) ========= /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=aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:05:51 INFO - MultiFileLogger online at 20160516 05:05:51 in /builds/slave/test 05:05:51 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 05:05:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:51 INFO - {'append_to_log': False, 05:05:51 INFO - 'base_work_dir': '/builds/slave/test', 05:05:51 INFO - 'blob_upload_branch': 'Fx-Team', 05:05:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:51 INFO - 'branch': 'Fx-Team', 05:05:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:51 INFO - 'config_files': ('talos/linux_config.py',), 05:05:51 INFO - 'default_actions': ('clobber', 05:05:51 INFO - 'read-buildbot-config', 05:05:51 INFO - 'download-and-extract', 05:05:51 INFO - 'populate-webroot', 05:05:51 INFO - 'create-virtualenv', 05:05:51 INFO - 'install', 05:05:51 INFO - 'run-tests'), 05:05:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:51 INFO - 'download_minidump_stackwalk': True, 05:05:51 INFO - 'download_symbols': 'ondemand', 05:05:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:05:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:05:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:05:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:05:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:51 INFO - 'installer_path': 'installer.exe', 05:05:51 INFO - 'log_level': 'info', 05:05:51 INFO - 'log_name': 'talos', 05:05:51 INFO - 'log_to_console': True, 05:05:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:05:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:05:51 INFO - 'opt_config_files': (), 05:05:51 INFO - 'pip_index': False, 05:05:51 INFO - 'sps_profile': False, 05:05:51 INFO - 'sps_profile_interval': 0, 05:05:51 INFO - 'suite': 'dromaeojs-e10s', 05:05:51 INFO - 'system_bits': '32', 05:05:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:51 INFO - 'title': 'talos-linux64-ix-009', 05:05:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:51 INFO - 'use_talos_json': True, 05:05:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:51 INFO - 'work_dir': 'build'} 05:05:51 INFO - ##### 05:05:51 INFO - ##### Running clobber step. 05:05:51 INFO - ##### 05:05:51 INFO - Running pre-action listener: _resource_record_pre_action 05:05:51 INFO - Running main action method: clobber 05:05:51 INFO - rmtree: /builds/slave/test/build 05:05:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:52 INFO - Running post-action listener: _resource_record_post_action 05:05:52 INFO - ##### 05:05:52 INFO - ##### Finished clobber step (success) 05:05:52 INFO - ##### 05:05:52 INFO - ##### 05:05:52 INFO - ##### Running read-buildbot-config step. 05:05:52 INFO - ##### 05:05:52 INFO - Running pre-action listener: _resource_record_pre_action 05:05:52 INFO - Running main action method: read_buildbot_config 05:05:52 INFO - Using buildbot properties: 05:05:52 INFO - { 05:05:52 INFO - "project": "", 05:05:52 INFO - "product": "firefox", 05:05:52 INFO - "script_repo_revision": "production", 05:05:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:05:52 INFO - "repository": "", 05:05:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:05:52 INFO - "buildid": "20160516023002", 05:05:52 INFO - "pgo_build": "True", 05:05:52 INFO - "basedir": "/builds/slave/test", 05:05:52 INFO - "buildnumber": 748, 05:05:52 INFO - "slavename": "talos-linux64-ix-009", 05:05:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:05:52 INFO - "platform": "ubuntu64_hw", 05:05:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:05:52 INFO - "branch": "fx-team", 05:05:52 INFO - "repo_path": "integration/fx-team", 05:05:52 INFO - "revision": "0c29ad917ac38c9ef26c9ff0b5d9762e75d13948", 05:05:52 INFO - "stage_platform": "linux64-pgo", 05:05:52 INFO - "builduid": "70f2d249bc9f421eb856f88c10d290d5", 05:05:52 INFO - "slavebuilddir": "test" 05:05:52 INFO - } 05:05:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:05:52 INFO - Running post-action listener: _resource_record_post_action 05:05:52 INFO - ##### 05:05:52 INFO - ##### Finished read-buildbot-config step (success) 05:05:52 INFO - ##### 05:05:52 INFO - ##### 05:05:52 INFO - ##### Running download-and-extract step. 05:05:52 INFO - ##### 05:05:52 INFO - Running pre-action listener: _resource_record_pre_action 05:05:52 INFO - Running main action method: download_and_extract 05:05:52 INFO - mkdir: /builds/slave/test/build/tests 05:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:52 INFO - https://queue.taskcluster.net/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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 05:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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 05:05:56 INFO - Downloaded 1361 bytes. 05:05:56 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:05:56 INFO - Using the following test package requirements: 05:05:56 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:56 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:05:56 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:05:56 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:56 INFO - u'jsshell-linux-x86_64.zip'], 05:05:56 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:05:56 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:56 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:05:56 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:05:56 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:05:56 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:05:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:05:56 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')]} 05:05:56 INFO - https://queue.taskcluster.net/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:05:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:05:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:05:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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 05:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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 05:06:00 INFO - Downloaded 24023189 bytes. 05:06:00 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'] 05:06:00 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 05:06:02 INFO - Return code: 0 05:06:02 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 05:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:06:02 INFO - https://queue.taskcluster.net/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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 05:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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 05:06:03 INFO - Downloaded 24023189 bytes. 05:06:03 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'] 05:06:03 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 05:06:04 INFO - Return code: 0 05:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:04 INFO - https://queue.taskcluster.net/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:06:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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 05:06:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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 05:06:05 INFO - Downloaded 10840194 bytes. 05:06:05 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'] 05:06:05 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 05:06:05 INFO - Return code: 0 05:06:05 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')]} 05:06:05 INFO - https://queue.taskcluster.net/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:06:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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 05:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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 05:06:06 INFO - Downloaded 58413528 bytes. 05:06:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:06 INFO - mkdir: /builds/slave/test/properties 05:06:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:06 INFO - Contents: 05:06:06 INFO - build_url:https://queue.taskcluster.net/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:07 INFO - Running post-action listener: _resource_record_post_action 05:06:07 INFO - Running post-action listener: set_extra_try_arguments 05:06:07 INFO - ##### 05:06:07 INFO - ##### Finished download-and-extract step (success) 05:06:07 INFO - ##### 05:06:07 INFO - ##### 05:06:07 INFO - ##### Running populate-webroot step. 05:06:07 INFO - ##### 05:06:07 INFO - Running pre-action listener: _resource_record_pre_action 05:06:07 INFO - Running main action method: populate_webroot 05:06:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:07 INFO - '--tppagecycles', 05:06:07 INFO - '7'], 05:06:07 INFO - 'tests': ['tsvgm']}}, 05:06:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:06:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:06:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['damp', 'tps']}, 05:06:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'tests': ['damp', 'tps']}, 05:06:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['dromaeo_dom']}, 05:06:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['tsvgx', 05:06:07 INFO - 'tsvgr_opacity', 05:06:07 INFO - 'tart', 05:06:07 INFO - 'tscrollx', 05:06:07 INFO - 'cart']}, 05:06:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:06:07 INFO - 'tsvgr_opacity', 05:06:07 INFO - 'tart', 05:06:07 INFO - 'tscrollx', 05:06:07 INFO - 'cart']}, 05:06:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['tp5o']}, 05:06:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'tests': ['tp5o']}, 05:06:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'talos_options': ['--disable-e10s', 05:06:07 INFO - '--xperf_path', 05:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:07 INFO - 'tests': ['tp5n']}, 05:06:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'talos_options': ['--xperf_path', 05:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:07 INFO - 'tests': ['tp5n']}}, 05:06:07 INFO - 'talos.zip': {'path': '', 05:06:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:07 INFO - Running post-action listener: _resource_record_post_action 05:06:07 INFO - ##### 05:06:07 INFO - ##### Finished populate-webroot step (success) 05:06:07 INFO - ##### 05:06:07 INFO - ##### 05:06:07 INFO - ##### Running create-virtualenv step. 05:06:07 INFO - ##### 05:06:07 INFO - Running pre-action listener: _resource_record_pre_action 05:06:07 INFO - Running main action method: create_virtualenv 05:06:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:07 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 05:06:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:07 INFO - Using real prefix '/usr' 05:06:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:10 INFO - Installing pip.................done. 05:06:10 INFO - Return code: 0 05:06:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:10 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')]} 05:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 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')]} 05:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 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 0x7f86829b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d04770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d939c0>, '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 0x1d948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d94d50>, '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': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', '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 05:06:10 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 05:06:10 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 05:06:10 INFO - Using env: {'DISPLAY': ':0', 05:06:10 INFO - 'HOME': '/home/cltbld', 05:06:10 INFO - 'LANG': 'en_US.UTF-8', 05:06:10 INFO - 'LANGUAGE': 'en_US:en', 05:06:10 INFO - 'LOGNAME': 'cltbld', 05:06:10 INFO - 'MAIL': '/var/mail/cltbld', 05:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:10 INFO - 'MOZ_NO_REMOTE': '1', 05:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:10 INFO - 'NO_EM_RESTART': '1', 05:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:10 INFO - 'PWD': '/builds/slave/test', 05:06:10 INFO - 'SHELL': '/bin/bash', 05:06:10 INFO - 'SHLVL': '1', 05:06:10 INFO - 'TERM': 'linux', 05:06:10 INFO - 'TMOUT': '86400', 05:06:10 INFO - 'USER': 'cltbld', 05:06:10 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', 05:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:10 INFO - '_': '/tools/buildbot/bin/python'} 05:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:10 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 05:06:10 INFO - Cleaning up... 05:06:10 INFO - Return code: 0 05:06:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:06:10 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')]} 05:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 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')]} 05:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 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 0x7f86829b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d04770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d939c0>, '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 0x1d948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d94d50>, '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': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', '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 05:06:10 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 05:06:10 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 05:06:10 INFO - Using env: {'DISPLAY': ':0', 05:06:10 INFO - 'HOME': '/home/cltbld', 05:06:10 INFO - 'LANG': 'en_US.UTF-8', 05:06:10 INFO - 'LANGUAGE': 'en_US:en', 05:06:10 INFO - 'LOGNAME': 'cltbld', 05:06:10 INFO - 'MAIL': '/var/mail/cltbld', 05:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:10 INFO - 'MOZ_NO_REMOTE': '1', 05:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:10 INFO - 'NO_EM_RESTART': '1', 05:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:10 INFO - 'PWD': '/builds/slave/test', 05:06:10 INFO - 'SHELL': '/bin/bash', 05:06:10 INFO - 'SHLVL': '1', 05:06:10 INFO - 'TERM': 'linux', 05:06:10 INFO - 'TMOUT': '86400', 05:06:10 INFO - 'USER': 'cltbld', 05:06:10 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', 05:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:10 INFO - '_': '/tools/buildbot/bin/python'} 05:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:10 INFO - Downloading/unpacking psutil>=3.1.1 05:06:10 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 05:06:10 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 05:06:10 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 05:06:10 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 05:06:10 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 05:06:10 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 05:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:12 INFO - Installing collected packages: psutil 05:06:12 INFO - Running setup.py install for psutil 05:06:12 INFO - building 'psutil._psutil_linux' extension 05:06:12 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 05:06:12 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 05:06:12 INFO - building 'psutil._psutil_posix' extension 05:06:12 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 05:06:13 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 05:06:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:13 INFO - Successfully installed psutil 05:06:13 INFO - Cleaning up... 05:06:13 INFO - Return code: 0 05:06:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:06:13 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')]} 05:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:13 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')]} 05:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:13 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 0x7f86829b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d04770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d939c0>, '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 0x1d948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d94d50>, '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': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', '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 05:06:13 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 05:06:13 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 05:06:13 INFO - Using env: {'DISPLAY': ':0', 05:06:13 INFO - 'HOME': '/home/cltbld', 05:06:13 INFO - 'LANG': 'en_US.UTF-8', 05:06:13 INFO - 'LANGUAGE': 'en_US:en', 05:06:13 INFO - 'LOGNAME': 'cltbld', 05:06:13 INFO - 'MAIL': '/var/mail/cltbld', 05:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:13 INFO - 'MOZ_NO_REMOTE': '1', 05:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:13 INFO - 'NO_EM_RESTART': '1', 05:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:13 INFO - 'PWD': '/builds/slave/test', 05:06:13 INFO - 'SHELL': '/bin/bash', 05:06:13 INFO - 'SHLVL': '1', 05:06:13 INFO - 'TERM': 'linux', 05:06:13 INFO - 'TMOUT': '86400', 05:06:13 INFO - 'USER': 'cltbld', 05:06:13 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', 05:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:13 INFO - '_': '/tools/buildbot/bin/python'} 05:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:06:13 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 05:06:13 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 05:06:13 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 05:06:13 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 05:06:13 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 05:06:13 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 05:06:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:06:15 INFO - Installing collected packages: mozsystemmonitor 05:06:15 INFO - Running setup.py install for mozsystemmonitor 05:06:15 INFO - Successfully installed mozsystemmonitor 05:06:15 INFO - Cleaning up... 05:06:15 INFO - Return code: 0 05:06:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f86829b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d04770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d939c0>, '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 0x1d948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d94d50>, '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': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', '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 05:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:06:15 INFO - Using env: {'DISPLAY': ':0', 05:06:15 INFO - 'HOME': '/home/cltbld', 05:06:15 INFO - 'LANG': 'en_US.UTF-8', 05:06:15 INFO - 'LANGUAGE': 'en_US:en', 05:06:15 INFO - 'LOGNAME': 'cltbld', 05:06:15 INFO - 'MAIL': '/var/mail/cltbld', 05:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:15 INFO - 'MOZ_NO_REMOTE': '1', 05:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:15 INFO - 'NO_EM_RESTART': '1', 05:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:15 INFO - 'PWD': '/builds/slave/test', 05:06:15 INFO - 'SHELL': '/bin/bash', 05:06:15 INFO - 'SHLVL': '1', 05:06:15 INFO - 'TERM': 'linux', 05:06:15 INFO - 'TMOUT': '86400', 05:06:15 INFO - 'USER': 'cltbld', 05:06:15 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', 05:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:15 INFO - '_': '/tools/buildbot/bin/python'} 05:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:15 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:17 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:17 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 05:06:17 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 05:06:17 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 05:06:17 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 05:06:17 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 05:06:17 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 05:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:18 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 05:06:18 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 05:06:18 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 05:06:18 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 05:06:18 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 05:06:18 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 05:06:18 INFO - Downloading docopt-0.6.1.tar.gz 05:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:18 INFO - Running setup.py install for blobuploader 05:06:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:18 INFO - Running setup.py install for requests 05:06:18 INFO - Running setup.py install for docopt 05:06:18 INFO - Successfully installed blobuploader requests docopt 05:06:18 INFO - Cleaning up... 05:06:18 INFO - Return code: 0 05:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:18 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 0x7f86829b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d04770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d939c0>, '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 0x1d948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d94d50>, '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': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', '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 05:06:18 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 05:06:18 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 05:06:18 INFO - Using env: {'DISPLAY': ':0', 05:06:18 INFO - 'HOME': '/home/cltbld', 05:06:18 INFO - 'LANG': 'en_US.UTF-8', 05:06:18 INFO - 'LANGUAGE': 'en_US:en', 05:06:18 INFO - 'LOGNAME': 'cltbld', 05:06:18 INFO - 'MAIL': '/var/mail/cltbld', 05:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:18 INFO - 'MOZ_NO_REMOTE': '1', 05:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:18 INFO - 'NO_EM_RESTART': '1', 05:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:18 INFO - 'PWD': '/builds/slave/test', 05:06:18 INFO - 'SHELL': '/bin/bash', 05:06:18 INFO - 'SHLVL': '1', 05:06:18 INFO - 'TERM': 'linux', 05:06:18 INFO - 'TMOUT': '86400', 05:06:18 INFO - 'USER': 'cltbld', 05:06:18 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', 05:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:18 INFO - '_': '/tools/buildbot/bin/python'} 05:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:19 INFO - Running setup.py (path:/tmp/pip-RzaNRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:19 INFO - Running setup.py (path:/tmp/pip-pmJW4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:19 INFO - Running setup.py (path:/tmp/pip-SJH6Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:19 INFO - Running setup.py (path:/tmp/pip-Te2DZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:19 INFO - Running setup.py (path:/tmp/pip-upnuIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:19 INFO - Running setup.py (path:/tmp/pip-4hQlpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:19 INFO - Running setup.py (path:/tmp/pip-M31V_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:19 INFO - Running setup.py (path:/tmp/pip-hnmeGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:19 INFO - Running setup.py (path:/tmp/pip-mod9Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:19 INFO - Running setup.py (path:/tmp/pip-4tqgHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:19 INFO - Running setup.py (path:/tmp/pip-sH1Elu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:19 INFO - Running setup.py (path:/tmp/pip-02lr7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:20 INFO - Running setup.py (path:/tmp/pip-0QrwSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:20 INFO - Running setup.py (path:/tmp/pip-MeGYaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:20 INFO - Running setup.py (path:/tmp/pip-f7RLkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:20 INFO - Running setup.py (path:/tmp/pip-PwBWgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:20 INFO - Running setup.py (path:/tmp/pip-6aGNcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:20 INFO - Running setup.py install for manifestparser 05:06:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:20 INFO - Running setup.py install for mozcrash 05:06:20 INFO - Running setup.py install for mozdebug 05:06:20 INFO - Running setup.py install for mozdevice 05:06:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:20 INFO - Running setup.py install for mozfile 05:06:20 INFO - Running setup.py install for mozhttpd 05:06:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Running setup.py install for mozinfo 05:06:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Running setup.py install for mozInstall 05:06:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Running setup.py install for mozleak 05:06:21 INFO - Running setup.py install for mozlog 05:06:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Running setup.py install for moznetwork 05:06:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Running setup.py install for mozprocess 05:06:21 INFO - Running setup.py install for mozprofile 05:06:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Running setup.py install for mozrunner 05:06:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:21 INFO - Running setup.py install for mozscreenshot 05:06:21 INFO - Running setup.py install for moztest 05:06:22 INFO - Running setup.py install for mozversion 05:06:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:22 INFO - Cleaning up... 05:06:22 INFO - Return code: 0 05:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:22 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')]} 05:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:22 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')]} 05:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:22 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 0x7f86829b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d04770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d939c0>, '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 0x1d948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d94d50>, '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': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', '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 05:06:22 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 05:06:22 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 05:06:22 INFO - Using env: {'DISPLAY': ':0', 05:06:22 INFO - 'HOME': '/home/cltbld', 05:06:22 INFO - 'LANG': 'en_US.UTF-8', 05:06:22 INFO - 'LANGUAGE': 'en_US:en', 05:06:22 INFO - 'LOGNAME': 'cltbld', 05:06:22 INFO - 'MAIL': '/var/mail/cltbld', 05:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:22 INFO - 'MOZ_NO_REMOTE': '1', 05:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:22 INFO - 'NO_EM_RESTART': '1', 05:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:22 INFO - 'PWD': '/builds/slave/test', 05:06:22 INFO - 'SHELL': '/bin/bash', 05:06:22 INFO - 'SHLVL': '1', 05:06:22 INFO - 'TERM': 'linux', 05:06:22 INFO - 'TMOUT': '86400', 05:06:22 INFO - 'USER': 'cltbld', 05:06:22 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', 05:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:22 INFO - '_': '/tools/buildbot/bin/python'} 05:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:22 INFO - Running setup.py (path:/tmp/pip-Y0TmHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:22 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)) 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:22 INFO - Running setup.py (path:/tmp/pip-uh_Qhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:22 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)) 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:22 INFO - Running setup.py (path:/tmp/pip-VCiX3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:22 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)) 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:22 INFO - Running setup.py (path:/tmp/pip-s_vHlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:22 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)) 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:22 INFO - Running setup.py (path:/tmp/pip-MSy0um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:22 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)) 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:22 INFO - Running setup.py (path:/tmp/pip-wHUiXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:22 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)) 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:22 INFO - Running setup.py (path:/tmp/pip-QoDDMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:22 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)) 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:22 INFO - Running setup.py (path:/tmp/pip-e3JKt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:22 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)) 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:22 INFO - Running setup.py (path:/tmp/pip-4hmyfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:23 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)) 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:23 INFO - Running setup.py (path:/tmp/pip-Bp9Dl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:23 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)) 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:23 INFO - Running setup.py (path:/tmp/pip-1rPjG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:23 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)) 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:23 INFO - Running setup.py (path:/tmp/pip-Yi94Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:23 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)) 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:23 INFO - Running setup.py (path:/tmp/pip-NEr8fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:23 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)) 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:23 INFO - Running setup.py (path:/tmp/pip-7eoJ6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:23 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)) 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:23 INFO - Running setup.py (path:/tmp/pip-06B_8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:23 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)) 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:23 INFO - Running setup.py (path:/tmp/pip-zLgMrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:23 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)) 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:23 INFO - Running setup.py (path:/tmp/pip-GYuJN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 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)) 05:06:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:25 INFO - Downloading blessings-1.6.tar.gz 05:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:25 INFO - Installing collected packages: blessings 05:06:25 INFO - Running setup.py install for blessings 05:06:25 INFO - Successfully installed blessings 05:06:25 INFO - Cleaning up... 05:06:25 INFO - Return code: 0 05:06:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:25 INFO - Reading from file tmpfile_stdout 05:06:25 INFO - Current package versions: 05:06:25 INFO - argparse == 1.2.1 05:06:25 INFO - blessings == 1.6 05:06:25 INFO - blobuploader == 1.2.4 05:06:25 INFO - docopt == 0.6.1 05:06:25 INFO - manifestparser == 1.1 05:06:25 INFO - mozInstall == 1.12 05:06:25 INFO - mozcrash == 0.17 05:06:25 INFO - mozdebug == 0.1 05:06:25 INFO - mozdevice == 0.48 05:06:25 INFO - mozfile == 1.2 05:06:25 INFO - mozhttpd == 0.7 05:06:25 INFO - mozinfo == 0.9 05:06:25 INFO - mozleak == 0.1 05:06:25 INFO - mozlog == 3.2 05:06:25 INFO - moznetwork == 0.27 05:06:25 INFO - mozprocess == 0.22 05:06:25 INFO - mozprofile == 0.28 05:06:25 INFO - mozrunner == 6.11 05:06:25 INFO - mozscreenshot == 0.1 05:06:25 INFO - mozsystemmonitor == 0.3 05:06:25 INFO - moztest == 0.7 05:06:25 INFO - mozversion == 1.4 05:06:25 INFO - psutil == 3.1.1 05:06:25 INFO - requests == 1.2.3 05:06:25 INFO - wsgiref == 0.1.2 05:06:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:25 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 0x7f86829b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d04770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d939c0>, '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 0x1d948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d94d50>, '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': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', '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 05:06:25 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 05:06:25 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 05:06:25 INFO - Using env: {'DISPLAY': ':0', 05:06:25 INFO - 'HOME': '/home/cltbld', 05:06:25 INFO - 'LANG': 'en_US.UTF-8', 05:06:25 INFO - 'LANGUAGE': 'en_US:en', 05:06:25 INFO - 'LOGNAME': 'cltbld', 05:06:25 INFO - 'MAIL': '/var/mail/cltbld', 05:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:25 INFO - 'MOZ_NO_REMOTE': '1', 05:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:25 INFO - 'NO_EM_RESTART': '1', 05:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:25 INFO - 'PWD': '/builds/slave/test', 05:06:25 INFO - 'SHELL': '/bin/bash', 05:06:25 INFO - 'SHLVL': '1', 05:06:26 INFO - 'TERM': 'linux', 05:06:26 INFO - 'TMOUT': '86400', 05:06:26 INFO - 'USER': 'cltbld', 05:06:26 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', 05:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:26 INFO - '_': '/tools/buildbot/bin/python'} 05:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 INFO - Cleaning up... 05:06:26 INFO - Return code: 0 05:06:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86829b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d04770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d939c0>, '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 0x1d948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d94d50>, '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': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', '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 05:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:06:26 INFO - Using env: {'DISPLAY': ':0', 05:06:26 INFO - 'HOME': '/home/cltbld', 05:06:26 INFO - 'LANG': 'en_US.UTF-8', 05:06:26 INFO - 'LANGUAGE': 'en_US:en', 05:06:26 INFO - 'LOGNAME': 'cltbld', 05:06:26 INFO - 'MAIL': '/var/mail/cltbld', 05:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:26 INFO - 'MOZ_NO_REMOTE': '1', 05:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:26 INFO - 'NO_EM_RESTART': '1', 05:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:26 INFO - 'PWD': '/builds/slave/test', 05:06:26 INFO - 'SHELL': '/bin/bash', 05:06:26 INFO - 'SHLVL': '1', 05:06:26 INFO - 'TERM': 'linux', 05:06:26 INFO - 'TMOUT': '86400', 05:06:26 INFO - 'USER': 'cltbld', 05:06:26 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', 05:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:26 INFO - '_': '/tools/buildbot/bin/python'} 05:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:26 INFO - Downloading/unpacking jsonschema 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:28 INFO - Downloading/unpacking functools32 (from jsonschema) 05:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:28 INFO - warning: no files found matching '*.txt' 05:06:28 INFO - no previously-included directories found matching 'build' 05:06:28 INFO - no previously-included directories found matching 'dist' 05:06:28 INFO - no previously-included directories found matching '.git*' 05:06:28 INFO - Installing collected packages: jsonschema, functools32 05:06:28 INFO - Running setup.py install for functools32 05:06:28 INFO - warning: no files found matching '*.txt' 05:06:28 INFO - no previously-included directories found matching 'build' 05:06:28 INFO - no previously-included directories found matching 'dist' 05:06:28 INFO - no previously-included directories found matching '.git*' 05:06:28 INFO - Successfully installed jsonschema functools32 05:06:28 INFO - Cleaning up... 05:06:28 INFO - Return code: 0 05:06:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86829b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d04770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d939c0>, '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 0x1d948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d94d50>, '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': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', '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 05:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:06:28 INFO - Using env: {'DISPLAY': ':0', 05:06:28 INFO - 'HOME': '/home/cltbld', 05:06:28 INFO - 'LANG': 'en_US.UTF-8', 05:06:28 INFO - 'LANGUAGE': 'en_US:en', 05:06:28 INFO - 'LOGNAME': 'cltbld', 05:06:28 INFO - 'MAIL': '/var/mail/cltbld', 05:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:28 INFO - 'MOZ_NO_REMOTE': '1', 05:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:28 INFO - 'NO_EM_RESTART': '1', 05:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:28 INFO - 'PWD': '/builds/slave/test', 05:06:28 INFO - 'SHELL': '/bin/bash', 05:06:28 INFO - 'SHLVL': '1', 05:06:28 INFO - 'TERM': 'linux', 05:06:28 INFO - 'TMOUT': '86400', 05:06:28 INFO - 'USER': 'cltbld', 05:06:28 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', 05:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:28 INFO - '_': '/tools/buildbot/bin/python'} 05:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:29 INFO - Downloading/unpacking flake8 05:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:06:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:06:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:31 INFO - no previously-included directories found matching 'docs/_build' 05:06:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:06:31 INFO - Running setup.py install for pep8 05:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:31 INFO - no previously-included directories found matching 'docs/_build' 05:06:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:06:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:06:31 INFO - Cleaning up... 05:06:31 INFO - Return code: 0 05:06:31 INFO - Running post-action listener: _resource_record_post_action 05:06:31 INFO - Running post-action listener: _start_resource_monitoring 05:06:31 INFO - Starting resource monitoring. 05:06:31 INFO - ##### 05:06:31 INFO - ##### Finished create-virtualenv step (success) 05:06:31 INFO - ##### 05:06:31 INFO - ##### 05:06:31 INFO - ##### Running install step. 05:06:31 INFO - ##### 05:06:31 INFO - Running pre-action listener: _resource_record_pre_action 05:06:31 INFO - Running main action method: install 05:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:32 INFO - Reading from file tmpfile_stdout 05:06:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:32 INFO - Reading from file tmpfile_stdout 05:06:32 INFO - Output received: 05:06:32 INFO - Usage: mozinstall [options] installer 05:06:32 INFO - Options: 05:06:32 INFO - -h, --help show this help message and exit 05:06:32 INFO - -d DEST, --destination=DEST 05:06:32 INFO - Directory to install application into. [default: 05:06:32 INFO - "/builds/slave/test"] 05:06:32 INFO - --app=APP Application being installed. [default: firefox] 05:06:32 INFO - mkdir: /builds/slave/test/build/application 05:06:32 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'] 05:06:32 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 05:06:48 INFO - Reading from file tmpfile_stdout 05:06:48 INFO - Output received: 05:06:48 INFO - /builds/slave/test/build/application/firefox/firefox 05:06:48 INFO - Running post-action listener: _resource_record_post_action 05:06:48 INFO - ##### 05:06:48 INFO - ##### Finished install step (success) 05:06:48 INFO - ##### 05:06:48 INFO - ##### 05:06:48 INFO - ##### Running run-tests step. 05:06:48 INFO - ##### 05:06:48 INFO - Running pre-action listener: _resource_record_pre_action 05:06:48 INFO - Running main action method: run_tests 05:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:48 INFO - Python 2.7.3 05:06:48 INFO - Return code: 0 05:06:48 INFO - grabbing minidump binary from tooltool 05:06:48 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')]} 05:06:48 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 0x1d939c0>, '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 0x1d948c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d94d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:48 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 05:06:48 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 05:06:48 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 05:06:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:48 INFO - Return code: 0 05:06:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:06:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:06:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:06:49 INFO - Return code: 0 05:06:49 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/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 05:06:49 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/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 05:06:49 INFO - Using env: {'DISPLAY': ':0', 05:06:49 INFO - 'HOME': '/home/cltbld', 05:06:49 INFO - 'LANG': 'en_US.UTF-8', 05:06:49 INFO - 'LANGUAGE': 'en_US:en', 05:06:49 INFO - 'LOGNAME': 'cltbld', 05:06:49 INFO - 'MAIL': '/var/mail/cltbld', 05:06:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:49 INFO - 'MOZ_NO_REMOTE': '1', 05:06:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:49 INFO - 'NO_EM_RESTART': '1', 05:06:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:49 INFO - 'PWD': '/builds/slave/test', 05:06:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:49 INFO - 'SHELL': '/bin/bash', 05:06:49 INFO - 'SHLVL': '1', 05:06:49 INFO - 'TERM': 'linux', 05:06:49 INFO - 'TMOUT': '86400', 05:06:49 INFO - 'USER': 'cltbld', 05:06:49 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997', 05:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:49 INFO - '_': '/tools/buildbot/bin/python'} 05:06:49 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/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 05:06:49 INFO - mozversion application_buildid: 20160516023002 05:06:49 INFO - mozversion application_changeset: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 05:06:49 INFO - mozversion application_display_name: Nightly 05:06:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:49 INFO - mozversion application_name: Firefox 05:06:49 INFO - mozversion application_remotingname: firefox 05:06:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:06:49 INFO - mozversion application_vendor: Mozilla 05:06:49 INFO - mozversion application_version: 49.0a1 05:06:49 INFO - mozversion platform_buildid: 20160516023002 05:06:49 INFO - mozversion platform_changeset: 0c29ad917ac38c9ef26c9ff0b5d9762e75d13948 05:06:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:06:49 INFO - mozversion platform_version: 49.0a1 05:06:49 INFO - using testdate: 1463400409 05:06:49 INFO - actual date: 1463400409 05:06:49 INFO - starting webserver on 'localhost:47625' 05:06:49 INFO - SUITE-START | Running 2 tests 05:06:49 INFO - TEST-START | dromaeo_css 05:06:49 INFO - operating with platform_type : linux_ 05:06:49 INFO - Initialising browser for dromaeo_css test... 05:06:49 INFO - TEST-INFO | started process 31177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMfDPxj/profile http://localhost:47625/getInfo.html) 05:06:54 INFO - PROCESS | 31177 | 05:06:54 INFO - PROCESS | 31177 | (process:31247): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:06:54 INFO - PROCESS | 31177 | __metrics Screen width/height:1600/1200 05:06:54 INFO - PROCESS | 31177 | colorDepth:24 05:06:54 INFO - PROCESS | 31177 | Browser inner width/height: 1024/697 05:06:54 INFO - PROCESS | 31177 | __metrics 05:06:55 ERROR - PROCESS | 31177 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:06:56 INFO - TEST-INFO | 31177: exit 0 05:06:56 INFO - Browser initialized. 05:06:56 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:56 INFO - TEST-INFO | started process 31298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMfDPxj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:58 INFO - PROCESS | 31298 | 05:06:58 INFO - PROCESS | 31298 | (process:31360): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:07:08 INFO - PROCESS | 31298 | RSS: Main: 163676160 05:07:08 INFO - PROCESS | 31298 | 05:07:57 INFO - PROCESS | 31298 | 1463400477811 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] 05:10:05 INFO - PROCESS | 31298 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47625/tests/dromaeo/cssquery-ext.html) 05:10:06 INFO - PROCESS | 31298 | RSS: Main: 166039552 05:10:06 INFO - PROCESS | 31298 | 05:13:08 INFO - PROCESS | 31298 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-ext.html (next: http://localhost:47625/tests/dromaeo/cssquery-jquery.html) 05:13:08 INFO - PROCESS | 31298 | RSS: Main: 166977536 05:13:08 INFO - PROCESS | 31298 | 05:16:10 INFO - PROCESS | 31298 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47625/tests/dromaeo/cssquery-mootools.html) 05:16:11 INFO - PROCESS | 31298 | RSS: Main: 168345600 05:16:11 INFO - PROCESS | 31298 | 05:19:12 INFO - PROCESS | 31298 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47625/tests/dromaeo/cssquery-prototype.html) 05:19:13 INFO - PROCESS | 31298 | RSS: Main: 165883904 05:19:13 INFO - PROCESS | 31298 | 05:22:15 INFO - PROCESS | 31298 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47625/tests/dromaeo/cssquery-yui.html) 05:22:16 INFO - PROCESS | 31298 | RSS: Main: 167215104 05:22:16 INFO - PROCESS | 31298 | 05:25:18 INFO - PROCESS | 31298 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-yui.html (next: http://localhost:47625/tests/dromaeo/cssquery-dojo.html) 05:25:19 INFO - PROCESS | 31298 | RSS: Main: 169275392 05:25:19 INFO - PROCESS | 31298 | 05:25:19 INFO - PROCESS | 31298 | __start_tp_report 05:25:19 INFO - PROCESS | 31298 | _x_x_mozilla_page_load 05:25:19 INFO - PROCESS | 31298 | _x_x_mozilla_page_load_details 05:25:19 INFO - PROCESS | 31298 | |i|pagename|runs| 05:25:19 INFO - PROCESS | 31298 | |0;dojo.html;3125.8905938292155;3222.258880457495;3243.4323993301173;3259.3318369734206;3278.7049165575095;5442.238086667865;5487.98472282628;5554.250176226208;5573.526250268732;5578.832635020955;5286.497782710646;5458.1266997280445;5465.508104270615;5470.507654311111;5557.055300598898;4923.18767403378;4952.380952380952;5098.133317336062;5107.7701503432245;5164.354455693038;628.3669129252406;5051.267566202899;5052.292679024939;5129.358830146231;5160.56135228506;5003.424606170264;5019.598432125439;5030.119729047402;5032.521910418523;5070.670406423589;4985.725785081819;5025.547700706954;5040.14317566011;5051.4695956924725;5051.570616497602;4969.776360063805;5026.220935754964;5035.269885866565;5046;5095.847124586268;5420.485053919911;5431.565474762009;5460.044492213887;5488.313960754906;5500.532454741352;5605.131204663284;5919.911201331984;5942.70286485674;5948.881022379572;5950.523958083386;5961.791337303217;6009.489193418564;6011.398860113997;6011.458968692838;6040.8187754367;5583.078791999355;5585.609007369486;5593.804216852391;5594.776208951637;5598.3282006159525;5708.743106560215;6014.458698717136;6063.848403789941;6091.543134264948;6104.511639068864;5837.416258374129;5851.765929362778;5858.238429004202;5889.322727886262;5929.555283353766;5907.05487122067;5930.703464826742;5938.317093534212;5941.197938278364;5967.910481342783;5598.748056337475;5793.913091303634;5842.5618078644275;5850.0932355484965;5888.617239879394;5607.158926161027;5772.6536407815665;5822.7088645567555;5879.20630714848;5891.3224979127945;4397.934030989538;4399.6040356368085;4403.757793321334;4430.601245887886;4457.799399027052;3897.0841852165286;3961.267165574378;3966.167104907944;3975.582563830756;4003.619656132663;5641.069223578063;5651.208830763697;5652.519535839418;5655.519280861173;5669.40471250521;5846.6784326862435;5948.434898684618;5955.28536575605;5964.761409543569;5993.61041532299;5419.864503387447;5620.100783874561;5650.124230744241;5686.2039314496005;5696.515796157373;4910.8772280693265;4914.238293064581;4917.164082106051;4931.556159945622;4931.753412329441;5889.882202355929;6079.544034197453;6122.816315510542;6152.077188421773;6152.692365381713;5876.559258055578;5884.941150588439;5923.229980102559;5924.407559244041;5946.316173640087;6104.175936248727;6121.724522396414;6124.173236613;6132.724027418688;6141.508679305555;5571.9442805571425;5780.21967034445;5799.362070172362;5799.536037116936;5806.65160090396;5967.791127310524;5996.580239383201;5998.8500287491415;6003.2796064470795;6020.4280593343565;5755.482006619424;5815.76736930518;5828.096645019859;5835.970820146042;5844.26946631671;5474.2609747683555;5664.631798933056;5794.913076303943;5839.562032847469;5846.795362162304;5405.054115529688;5638.943610564006;5640.097584386478;5648.971755141198;5738.9139162913425;5700.629459085146;5791.565632577658;5799.4780469757925;5828.6502809831545;5840.123981402823;5439.728013599225;5656.406077361818;5715.457031581993;5731.799387021434;5737.713114344183 05:25:19 INFO - PROCESS | 31298 | |1;ext.html;602.7950496831077;628.8302158417227;634.235745926159;645.8482256669685;653.9607623542588;43271.78364108179;44180.558194418045;44262.557374426244;44268.55731442685;47252.52747472524;45055.549444505545;45538.544614553844;45722.771386143104;45756;46046.53953460464;9011.639534418631;9099.818003639923;9139.314551408637;9144.679936202234;9152.4966126863;8892.24415924644;8949.373543851932;9002.054784247657;9024.77438064047;9035.141661542177;9027.593758280893;9034.277257819358;9068.229200517964;9075.319351048698;9099.408538445014;8970.730878073668;8991.460512369278;9030.86453703195;9046.77383065422;9051.502167380824;8923.41997770143;9009.864852027225;9030.367874248805;9052.547372631341;9061.275097992146;41258.58741412607;41518;41561.79219103915;41591.37612935808;41597.79201103975;3738.2897249522503;3768.171002379472;3779.433085037266;3888.727789054739;3905.1213476967737;32503.837480812683;32930.67069329324;33148.34258287076;35192.64807351945;35253.29493410118;4107.609777071173;4177.937330940038;4264.0832221072305;4274.615284624368;4339.1972485090355;378684;380405;381593;382847;384769;62048.06927896085;62532.68733656302;62658;62896;62932.05601915975;36533.26933461316;37411.25177496489;37436.43845342322;66054.66972665106;66279;16147.434839780552;16151.273192706356;16229.675406491804;16247.59381015484;16291.918540407221;12555.435005424777;12690.555830545887;12753.171043882117;12761.68095797594;12774.489020439078;19913.701294480594;19974.70037949432;20032.098555565033;20036.298729544396;20165.58013038445;7299.817504562428;7374.594397308092;7598.658060387296;7682.193369696213;7827.608619568999;988.1995583577325;1078.6386560502162;1132.9180632495948;1201.6755476021426;1226.8527776666856;31076;31637.20906977298;31761;31895.681043189736;31926.361472770415;1159.6694941941676;1191.386435985468;1198.6523908066738;1259.6724851538484;1274.6176147156002;16671.249793759067;17242.224099915533;17298.740518892228;17302.134893255286;17421.128943553023;547051;558121;559151;559215;560935;58456.70771646115;59170.704146478995;59367.40632593705;59475.70262148748;59477.107843382386;1411.484808045056;1435.777454494555;1442.3653592419303;1464.1946929189116;1464.3410465290663;30175.69824301729;30669.866026794283;31254.843725781226;31492.37015259728;31707;50883.236751448014;50926;51079.48920510896;51208;51293.230601541756;353813;354465;355151;357081;358722.06389680936;28116.613323261103;28868;29008;29269;29278.56082158812;47945.280820788415;48087.5191248097;49103.26345104898;49289.50710492849;49477.50522494729;40475.39286910758;41329.58670413378;42053;42189.1562168761;42742.78628606837;40050.1989960205;40862.18275634411;40889;42198.78900605477;42358.36462453127;41541.37687934623;42518.14963700647;43879;44182.11635767331;46020.539794601624;36740.44889326609;36938.63061369459;37179;38033.61966380301;38061.80969095137;28996.130116096552;29229;29338.266543335732;29519.409611807216;29696.851515742284 05:25:19 INFO - PROCESS | 31298 | |2;jquery.html;387.7053439386067;397.52495767557764;408.0451742921563;410.3475473996345;412.13040484577516;13717.176969381819;18128.90935545322;18739;19660.410187694375;19823.10796014179;18603.348882789105;18845.43463696088;19195.23219071239;19287.710684339745;19482.805171948312;5504.2294078829;5603.103503439461;5716.59983801132;5730.197772311859;5791.333996590382;5602.13166959122;5618.634788738739;5653.067243904771;5655.971720141414;5666.3766985631755;5469.179623056533;5623.718814059301;5787.710614469281;5846.561507886904;5883.970580147094;5746.770129194827;5797.681127537984;5827.941720582782;5852.941470585303;5854.121881717734;4927.77824997876;5039.647224694273;5045.041442125985;5069.264956581312;5069.822556210552;21504.56990860174;21907.780922190894;22511.32466026022;22543;22567.210147644917;2241.3612120545567;2609.4389706213065;2716.4838680650614;2789.7210278972143;2792.287966568512;10416.27086103973;10439.53022113999;10540.472976351228;10690.51892664832;10750.623728169476;1975.224978324347;2060.485870104115;2079.625667379871;2095.8218551422997;2121.6287149748887;77668.61165694136;80433.79349309823;81302;82623.5868820658;83074.58462707709;10772.084372828398;10834.62078827253;10952.945235273774;11080.889191108146;11144.498497567629;15482.30329635169;15578.376864925503;15599.142047187286;15618.3752649895;15637.061776293458;8181.918180818235;8259.21537453941;8339.332853371716;8355.340229930625;8506.702265420681;8297.875531867026;8357.8328433431;8376.706815261437;8462.576871156542;8503.107173746792;4714.151452738472;4793.856184314476;4911.508849115131;4927.285543596158;4939.036887806915;1982.1873032056787;1998.4704053425853;2000.3898810862827;2014.587009663045;2033.4509682385674;972.3825370889394;1049.7113293844254;1055.382601178304;1066.6001496632578;1073.0878753059992;18062.36781712634;18257.908710456362;18896.244150233837;18915;19168;1057.7937302225992;1084.978300433987;1094.480121942087;1099.9715266226103;1100.8458815765798;8028;10663.946680266705;10705.250632455653;10778.4071876046;10833.512491937881;491326.1892159075;495559;501160;503399;504645;72099.27900720926;84100;85576.57211713902;88406.55796721103;93053.5347323259;1071.4160782373624;1085.8045551800594;1123.7303047268597;1151.8675352334421;1159.9826002609968;17010.149492525572;17020.262690241627;17085.402010929556;17202.65594688124;17231.655366892843;40390.59609403869;40989;41010.384844227956;41083;41580.376294355;55876;57895.71052144712;57975.42024579869;58093.4190658088;58125.418745813695;8365.539895305817;8383.832323353377;8493.490390576339;8702.869456958277;8712.69505567302;10205.367141257364;12948;13117.278549679859;13244.271565064015;13629.591112266648;9030.645403189574;11873.465694043962;11885.881141188478;11913.940430297793;12027.338496382434;11289.322640641587;11367.488463019019;11527.193096483166;11602.563461673144;11658.94170529142;11445.427728613702;11551.88448115508;11739.882601173878;11900.642980710592;12147.210431321935;7517.097948246245;8346.66613335484;8459.111793261618;8642.481451112953;8918.554072296229;10559.788804224027;11799.17405781587;12383.442745076673;12433.689157771129;12602.810957835456 05:25:19 INFO - PROCESS | 31298 | |3;mootools.html;1499.2204053891974;1558.2831897327228;1696.541933677907;1845.4463660901727;1846.0769615192412;7565;8582.656693732244;8622.482651040935;9064.365494415386;9143.268538516912;8630.395872288942;8910.688125915594;8988.370814043019;8991.370604057718;9013.81972360554;2331.743508214099;2346.85918844869;2355.6702061711376;2366.7869891709743;2374.8100151987887;2329.219711396684;2368.111958015744;2369.218158007853;2376.0733314007553;2379.167291447988;2354.6468029795496;2356.163561935514;2381.84518006329;2394.174009966559;2401.8799060047013;2288.3249441414823;2299.3906614747107;2307.1117619716447;2319.373769082355;2328.406256404623;2293.323469576479;2310.099061366052;2324.639680849471;2326.4649130699863;2328.848624839397;8964.282857371394;8982.730518084469;8992.77518062047;9003.5048072356;9013.324000699973;5187.195984622352;5416.864578385533;5422.105352616813;5436.2661040759385;5478.45215478453;3298.2743796365003;3299.1257316811066;3344.882929097494;3386.4920261960656;3395.1002984209204;1123.8258069999163;1143.2911594811187;1148.9942550287194;1161.117550661495;1192.248883203585;12208.26750394988;12218.450169742382;12251.571195008131;12286.262824230485;12380.690482737913;4656.278276867091;4737.881552961204;4756.5956893664425;4772.045590881838;4828.37231159947;10515.158787296998;10542.947285263524;10542.947285263524;10551.366917984946;10574.154067674568;5344.171653393731;5363.731813409314;5373.946260537423;5377.650452720561;5387.164989426645;4470.731756094645;4775.6657034007985;4974.204127339681;4980.601551875841;5004.199328107486;3915;4026.939595906064;4111.218868414991;4129.802357316345;4148.398482220061;1270.9809352859716;1283.62133170713;1294.2816736711027;1302.3358087375507;1326.7678156322604;1012.1902478017556;1015.8730158730159;1035.534009695625;1041.354360296621;1048.7430579507916;5789.652620842763;5807.738651760681;5895.380984996514;6058.0610005449225;6073.726682299307;448.4148186616497;456.99543004570194;458.3903408466798;462.4727810296265;464.9721016739006;4283.764392958355;4307.6769242306955;4321.416608757841;4321.611055005064;4356.150550642657;10827.133829293794;11073.05879000294;11078.279911805706;11088.22382433238;11110.50002749862;10898.618548350769;10901.073408760185;10953.288036277616;10959.890401096047;11017.779644407066;7755.806104847424;8102.189781021851;8105.55419451924;8316.085230624505;8319.66721331152;6024.096385542204;6188.690565471618;6239.438450539473;6246.187995560548;6371.362863713777;9869.272877246596;10165.79668406613;10191.643292484727;10249.538770755185;10335.069843713802;10419.374837509773;10449;10469.110125639101;10531.210159237935;10553.155747540332;7651.808704782202;7735.419843511647;7803.180666029985;7914.881276780968;7930.682772689028;8397.748067557983;8418.368622353226;8427.705030323908;8427.8735818964;8491.405601607828;7353.080864891888;7508.662110204945;7686.07767067933;7725.690972361042;7856.332211761835;7626.237376262329;7648.464607477423;7663.8850417242675;7828.608569571385;7828.960855195687;7118.216996130318;7122.928770712227;7185.964070179615;7194.712211511481;7199.2440793715905;4960.131976904099;5085.720285384339;5098.2352647103235;5110.48895110486;5133.820316289061;5224.686518808883;5369.328833895763;5381.838544843661;5414.675119492843;5465.562754979672 05:25:19 INFO - PROCESS | 31298 | |4;prototype.html;331.10630772253876;341.3412114618786;344.9775764575302;348.6182630020127;350.3850741947881;5548.4174161713045;5599.3403133511665;5656.971715141429;5769.221155144054;5775.480206781394;5604.523615492688;5623.0721930881355;5626.578006649497;5643.492085712285;5657.801976930808;4310.224159651261;4363.912721745563;4391.604755571998;4406.228909940747;4409.779511024436;4114.280000999813;4313.741175529462;4365.388845561624;4388.824447022132;4394.956050439503;4311.741295522263;4318.740875547462;4334.5448727883595;4334.97832510837;4339.674524410666;4366.912661746763;4394.143142087294;4398.208322501949;4399.306267087194;4401.339799030139;3800.619938006205;3830.0616348994677;3893.3186692329014;3893.98053009736;3895.0846551060763;5392.923724366108;5413.242146099549;5425.131978883399;5430.83707488776;5480.136753503828;4933.777979990909;4949.455559888409;4950.628702847301;4961.231009193581;4966.304717339575;5782.219400380936;5817.56368272377;5833.7958171464215;5862.560307976876;5877.676727780014;4170.727927981964;4177.665786737084;4191.517975432834;4223.493180818322;4238.152369526107;6105.633661980251;6115.908261376083;6159.3224745277985;6180.629162250234;6191.907121393183;4180.226658068206;4231.174920890458;4254.468191476066;4292.785360732013;4303.591158839905;4325.43769309994;4350.282203436397;4360.41134446852;4368.737875727466;4386.298192289219;4972.563443912529;4993.625478089158;5000.749812546864;5001.824936127218;5022.723750193702;5664.51851592611;5886.470217680429;5899.528037756969;5923.289205295392;5950.7917222896995;1473.197107576352;1503.6541595432893;1505.4429860951518;1508.751056075757;1513.1148278257124;926.6710317837205;951.533748463248;962.6678795815433;964.0118878149813;972.7840199750312;5028.19548872186;5046.26829109777;5058.620603454756;5075.3148324975655;5107.442230119775;5280.313559237351;5398.973005134949;5420.728963551806;5426.635485998706;5464.508194262536;4921.335619691367;4936.778610543537;5078;5114.232865070269;5116.516210298972;2896.7399181356177;2898.7680985521106;2905.5060639691305;2915.3877685686243;2916.460454815866;5471.589630777628;5482.533984611273;5489.286392768914;5541.5289700375915;5554.444555544414;5397.460253974571;5733.770649173986;6195;6220.875582488325;6229.626222426669;6323.9051414228825;6353.141086511088;6355.555111142268;6370.235571731329;6413.935860641427;5922.674252916131;6024.277086749618;6099.4815440688035;6106.542009349228;6141.416565426277;5963.821085367446;6046.183765191819;6056.212692349966;6062.272527296576;6068.4538391544975;5947.375525569752;5976.731047102804;6345.96827015862;6357.618542887441;6362.363763623601;4304.246756817607;4322.610965013164;4323.54602766705;4342.41377414045;4353.542877997765;6126.23422072241;6148.877022459616;6186.226721659793;6188.845278868064;6202.34875338083;5654.802081927113;5921.3190483094995;5925.200097986716;5934.902043121863;5942.673152976455;5890.852728681817;5910.408959104056;5920.200772895604;5924.733386997682;5955.255593050869;5629.860652951852;5778.855528611818;5844.912326315024;5874.853128671646;5883.646981181143;5836.737346819318;5839.299284085937;5953.10703394477;5978.671173085522;5980.9401905980385;5857.941420585739;5864.120381942743;5879.647221166743;5887.999040163097;5902.1736956826935 05:25:19 INFO - PROCESS | 31298 | |5;yui.html;784.6429874407145;793.468376187954;804.9476784009042;869.465278853505;901.7384958362076;14714.926425367872;15550.688986220282;15638.452654157107;15682.21588920555;15684.372625094997;14672.853271467282;14918.776218356734;14923.477678281262;14937.850621493782;14940;684.8322161070532;819.4673462249526;841.6507149532937;845.285733555148;857.087202129733;835.1022650650575;840.3403328387217;842.1957031035378;842.3303473738392;844.1136806353335;898.2185498616213;899.8065415935572;903.575319599787;903.5978989349709;904.0507467159489;898.3352319283715;898.6674930275807;899.2086963472168;902.0483390023522;903.9457632542036;641.413107007088;643.9581427207216;645.1484041065795;648.9578177418452;649.8018104478132;14699.92650036743;14729.631759205999;14759.704805903822;14809;14838.851611483855;14624.195669238188;14750.778738318933;14858;14861.405543778235;14966.775498367424;11982.880171198263;11987.160898737093;12091.214071085351;12132.575359862363;12162.878371216351;3895.2988462076814;3910.7262491625597;3917.784521851297;3941.980290098531;4033.4151548025666;60970;61594.38405615931;61637.6918115411;62122;62214.99999999955;10706;10706.625268115578;10811.243212975016;10968.451577421098;10997.890021099687;19087;19431.90284048599;21266.893665531574;21281.255156069463;21403.357899263046;8652.524111173945;8709.520976346235;8725.301975841918;8802.823943521222;8849.778755531162;4850.684705494202;4903.632227582945;4903.632227582945;5023.648344615842;5145.408278048072;3349.480830471281;3406.523086767805;3424.280901010816;3428.400029994741;3436.3127374525193;608.2457752387008;612.4273803993192;615.7106160104744;638.6615094000188;663.7743167323133;738.7525179064966;788.4047544104164;804.951702897828;806.8345989072226;832.142892820396;9707.708768736808;9971.950140249397;9990.500474976223;10024.749381265527;10062;662.6786008785735;742.4023660952985;765.2385876053363;784.9725259615886;793.9444238903337;4613.8385156520035;4896.094222568836;4926.432801640462;5022.84931452057;5076.086304465158;61166.38833611607;69038;69895.65052174809;69962.65018674976;70212;56553.71723141358;61306.69346653238;61795.691021544604;61947.38052619506;62285;58330.708346458;58573.70713146407;58648.4135158643;58682.7065864668;58939.41060589425;9868.660981470646;10026.348287361297;10155.492225388849;10157.542910568895;10305.53625086888;37077.258454831295;37155.25689486249;38261.617383825804;38507.42238866363;38841;50378.244326335865;50793.492065080354;50933.98132037413;51634.48365516297;51834.74082629714;13154.868451315364;13350.9332453341;13412.530561430303;13418.530351437652;13438.46246150143;13992.790108148183;14300.570982870531;14784.33470493852;14796;14937.178455185069;13537.1200871943;13600.455981761015;13730.45078196861;13894.652633684238;14065.156090634595;13261.138026028277;13561.254131022888;13667.453301868212;13681.179129252278;13722.313884305944;13242.20546767197;13253.933730331286;13436.462541498231;13456.058075934981;13587.932060339635;11371.658850234506;11460.598879039193;11752.087947009331;11954.402279885797;12374.876251237372;11638.825417618573;11758.176927614984;11991.160618756603;12085.51657933708;12111.75776484483 05:25:19 INFO - PROCESS | 31298 | __end_tp_report 05:25:19 INFO - PROCESS | 31298 | __start_cc_report 05:25:19 INFO - PROCESS | 31298 | _x_x_mozilla_cycle_collect,363 05:25:19 INFO - PROCESS | 31298 | __end_cc_report 05:25:19 INFO - PROCESS | 31298 | __startTimestamp1463401519115__endTimestamp 05:25:19 INFO - PROCESS | 31298 | 05:25:19 INFO - PROCESS | 31298 | ------- Summary: start ------- 05:25:19 INFO - PROCESS | 31298 | Number of tests: 6 05:25:19 INFO - PROCESS | 31298 | 05:25:19 INFO - PROCESS | 31298 | [#0] dojo.html Cycles:165 Average:5450.19 Median:5664.63 stddev:735.51 (13.0%) stddev-sans-first:714.80 05:25:19 INFO - PROCESS | 31298 | Values: 3125.9 3222.3 3243.4 3259.3 3278.7 5442.2 5488.0 5554.3 5573.5 5578.8 5286.5 5458.1 5465.5 5470.5 5557.1 4923.2 4952.4 5098.1 5107.8 5164.4 628.4 5051.3 5052.3 5129.4 5160.6 5003.4 5019.6 5030.1 5032.5 5070.7 4985.7 5025.5 5040.1 5051.5 5051.6 4969.8 5026.2 5035.3 5046.0 5095.8 5420.5 5431.6 5460.0 5488.3 5500.5 5605.1 5919.9 5942.7 5948.9 5950.5 5961.8 6009.5 6011.4 6011.5 6040.8 5583.1 5585.6 5593.8 5594.8 5598.3 5708.7 6014.5 6063.8 6091.5 6104.5 5837.4 5851.8 5858.2 5889.3 5929.6 5907.1 5930.7 5938.3 5941.2 5967.9 5598.7 5793.9 5842.6 5850.1 5888.6 5607.2 5772.7 5822.7 5879.2 5891.3 4397.9 4399.6 4403.8 4430.6 4457.8 3897.1 3961.3 3966.2 3975.6 4003.6 5641.1 5651.2 5652.5 5655.5 5669.4 5846.7 5948.4 5955.3 5964.8 5993.6 5419.9 5620.1 5650.1 5686.2 5696.5 4910.9 4914.2 4917.2 4931.6 4931.8 5889.9 6079.5 6122.8 6152.1 6152.7 5876.6 5884.9 5923.2 5924.4 5946.3 6104.2 6121.7 6124.2 6132.7 6141.5 5571.9 5780.2 5799.4 5799.5 5806.7 5967.8 5996.6 5998.9 6003.3 6020.4 5755.5 5815.8 5828.1 5836.0 5844.3 5474.3 5664.6 5794.9 5839.6 5846.8 5405.1 5638.9 5640.1 5649.0 5738.9 5700.6 5791.6 5799.5 5828.7 5840.1 5439.7 5656.4 5715.5 5731.8 5737.7 05:25:19 INFO - PROCESS | 31298 | 05:25:19 INFO - PROCESS | 31298 | [#1] ext.html Cycles:180 Average:59632.25 Median:41551.58 stddev:116802.81 (281.1%) stddev-sans-first:117046.39 05:25:19 INFO - PROCESS | 31298 | Values: 602.8 628.8 634.2 645.8 654.0 43271.8 44180.6 44262.6 44268.6 47252.5 45055.5 45538.5 45722.8 45756.0 46046.5 9011.6 9099.8 9139.3 9144.7 9152.5 8892.2 8949.4 9002.1 9024.8 9035.1 9027.6 9034.3 9068.2 9075.3 9099.4 8970.7 8991.5 9030.9 9046.8 9051.5 8923.4 9009.9 9030.4 9052.5 9061.3 41258.6 41518.0 41561.8 41591.4 41597.8 3738.3 3768.2 3779.4 3888.7 3905.1 32503.8 32930.7 33148.3 35192.6 35253.3 4107.6 4177.9 4264.1 4274.6 4339.2 378684.0 380405.0 381593.0 382847.0 384769.0 62048.1 62532.7 62658.0 62896.0 62932.1 36533.3 37411.3 37436.4 66054.7 66279.0 16147.4 16151.3 16229.7 16247.6 16291.9 12555.4 12690.6 12753.2 12761.7 12774.5 19913.7 19974.7 20032.1 20036.3 20165.6 7299.8 7374.6 7598.7 7682.2 7827.6 988.2 1078.6 1132.9 1201.7 1226.9 31076.0 31637.2 31761.0 31895.7 31926.4 1159.7 1191.4 1198.7 1259.7 1274.6 16671.2 17242.2 17298.7 17302.1 17421.1 547051.0 558121.0 559151.0 559215.0 560935.0 58456.7 59170.7 59367.4 59475.7 59477.1 1411.5 1435.8 1442.4 1464.2 1464.3 30175.7 30669.9 31254.8 31492.4 31707.0 50883.2 50926.0 51079.5 51208.0 51293.2 353813.0 354465.0 355151.0 357081.0 358722.1 28116.6 28868.0 29008.0 29269.0 29278.6 47945.3 48087.5 49103.3 49289.5 49477.5 40475.4 41329.6 42053.0 42189.2 42742.8 40050.2 40862.2 40889.0 42198.8 42358.4 41541.4 42518.1 43879.0 44182.1 46020.5 36740.4 36938.6 37179.0 38033.6 38061.8 28996.1 29229.0 29338.3 29519.4 29696.9 05:25:19 INFO - PROCESS | 31298 | 05:25:19 INFO - PROCESS | 31298 | [#2] jquery.html Cycles:180 Average:28938.19 Median:22527.16 stddev:82128.24 (364.6%) stddev-sans-first:82330.66 05:25:19 INFO - PROCESS | 31298 | Values: 387.7 397.5 408.0 410.3 412.1 13717.2 18128.9 18739.0 19660.4 19823.1 18603.3 18845.4 19195.2 19287.7 19482.8 5504.2 5603.1 5716.6 5730.2 5791.3 5602.1 5618.6 5653.1 5656.0 5666.4 5469.2 5623.7 5787.7 5846.6 5884.0 5746.8 5797.7 5827.9 5852.9 5854.1 4927.8 5039.6 5045.0 5069.3 5069.8 21504.6 21907.8 22511.3 22543.0 22567.2 2241.4 2609.4 2716.5 2789.7 2792.3 10416.3 10439.5 10540.5 10690.5 10750.6 1975.2 2060.5 2079.6 2095.8 2121.6 77668.6 80433.8 81302.0 82623.6 83074.6 10772.1 10834.6 10952.9 11080.9 11144.5 15482.3 15578.4 15599.1 15618.4 15637.1 8181.9 8259.2 8339.3 8355.3 8506.7 8297.9 8357.8 8376.7 8462.6 8503.1 4714.2 4793.9 4911.5 4927.3 4939.0 1982.2 1998.5 2000.4 2014.6 2033.5 972.4 1049.7 1055.4 1066.6 1073.1 18062.4 18257.9 18896.2 18915.0 19168.0 1057.8 1085.0 1094.5 1100.0 1100.8 8028.0 10663.9 10705.3 10778.4 10833.5 491326.2 495559.0 501160.0 503399.0 504645.0 72099.3 84100.0 85576.6 88406.6 93053.5 1071.4 1085.8 1123.7 1151.9 1160.0 17010.1 17020.3 17085.4 17202.7 17231.7 40390.6 40989.0 41010.4 41083.0 41580.4 55876.0 57895.7 57975.4 58093.4 58125.4 8365.5 8383.8 8493.5 8702.9 8712.7 10205.4 12948.0 13117.3 13244.3 13629.6 9030.6 11873.5 11885.9 11913.9 12027.3 11289.3 11367.5 11527.2 11602.6 11658.9 11445.4 11551.9 11739.9 11900.6 12147.2 7517.1 8346.7 8459.1 8642.5 8918.6 10559.8 11799.2 12383.4 12433.7 12602.8 05:25:19 INFO - PROCESS | 31298 | 05:25:19 INFO - PROCESS | 31298 | [#3] mootools.html Cycles:180 Average:5856.15 Median:452.71 stddev:3329.46 (735.5%) stddev-sans-first:3322.70 05:25:19 INFO - PROCESS | 31298 | Values: 1499.2 1558.3 1696.5 1845.4 1846.1 7565.0 8582.7 8622.5 9064.4 9143.3 8630.4 8910.7 8988.4 8991.4 9013.8 2331.7 2346.9 2355.7 2366.8 2374.8 2329.2 2368.1 2369.2 2376.1 2379.2 2354.6 2356.2 2381.8 2394.2 2401.9 2288.3 2299.4 2307.1 2319.4 2328.4 2293.3 2310.1 2324.6 2326.5 2328.8 8964.3 8982.7 8992.8 9003.5 9013.3 5187.2 5416.9 5422.1 5436.3 5478.5 3298.3 3299.1 3344.9 3386.5 3395.1 1123.8 1143.3 1149.0 1161.1 1192.2 12208.3 12218.5 12251.6 12286.3 12380.7 4656.3 4737.9 4756.6 4772.0 4828.4 10515.2 10542.9 10542.9 10551.4 10574.2 5344.2 5363.7 5373.9 5377.7 5387.2 4470.7 4775.7 4974.2 4980.6 5004.2 3915.0 4026.9 4111.2 4129.8 4148.4 1271.0 1283.6 1294.3 1302.3 1326.8 1012.2 1015.9 1035.5 1041.4 1048.7 5789.7 5807.7 5895.4 6058.1 6073.7 448.4 457.0 458.4 462.5 465.0 4283.8 4307.7 4321.4 4321.6 4356.2 10827.1 11073.1 11078.3 11088.2 11110.5 10898.6 10901.1 10953.3 10959.9 11017.8 7755.8 8102.2 8105.6 8316.1 8319.7 6024.1 6188.7 6239.4 6246.2 6371.4 9869.3 10165.8 10191.6 10249.5 10335.1 10419.4 10449.0 10469.1 10531.2 10553.2 7651.8 7735.4 7803.2 7914.9 7930.7 8397.7 8418.4 8427.7 8427.9 8491.4 7353.1 7508.7 7686.1 7725.7 7856.3 7626.2 7648.5 7663.9 7828.6 7829.0 7118.2 7122.9 7186.0 7194.7 7199.2 4960.1 5085.7 5098.2 5110.5 5133.8 5224.7 5369.3 5381.8 5414.7 5465.6 05:25:19 INFO - PROCESS | 31298 | 05:25:19 INFO - PROCESS | 31298 | [#4] prototype.html Cycles:180 Average:4884.28 Median:5475.86 stddev:1450.61 (26.5%) stddev-sans-first:1413.85 05:25:19 INFO - PROCESS | 31298 | Values: 331.1 341.3 345.0 348.6 350.4 5548.4 5599.3 5657.0 5769.2 5775.5 5604.5 5623.1 5626.6 5643.5 5657.8 4310.2 4363.9 4391.6 4406.2 4409.8 4114.3 4313.7 4365.4 4388.8 4395.0 4311.7 4318.7 4334.5 4335.0 4339.7 4366.9 4394.1 4398.2 4399.3 4401.3 3800.6 3830.1 3893.3 3894.0 3895.1 5392.9 5413.2 5425.1 5430.8 5480.1 4933.8 4949.5 4950.6 4961.2 4966.3 5782.2 5817.6 5833.8 5862.6 5877.7 4170.7 4177.7 4191.5 4223.5 4238.2 6105.6 6115.9 6159.3 6180.6 6191.9 4180.2 4231.2 4254.5 4292.8 4303.6 4325.4 4350.3 4360.4 4368.7 4386.3 4972.6 4993.6 5000.7 5001.8 5022.7 5664.5 5886.5 5899.5 5923.3 5950.8 1473.2 1503.7 1505.4 1508.8 1513.1 926.7 951.5 962.7 964.0 972.8 5028.2 5046.3 5058.6 5075.3 5107.4 5280.3 5399.0 5420.7 5426.6 5464.5 4921.3 4936.8 5078.0 5114.2 5116.5 2896.7 2898.8 2905.5 2915.4 2916.5 5471.6 5482.5 5489.3 5541.5 5554.4 5397.5 5733.8 6195.0 6220.9 6229.6 6323.9 6353.1 6355.6 6370.2 6413.9 5922.7 6024.3 6099.5 6106.5 6141.4 5963.8 6046.2 6056.2 6062.3 6068.5 5947.4 5976.7 6346.0 6357.6 6362.4 4304.2 4322.6 4323.5 4342.4 4353.5 6126.2 6148.9 6186.2 6188.8 6202.3 5654.8 5921.3 5925.2 5934.9 5942.7 5890.9 5910.4 5920.2 5924.7 5955.3 5629.9 5778.9 5844.9 5874.9 5883.6 5836.7 5839.3 5953.1 5978.7 5980.9 5857.9 5864.1 5879.6 5888.0 5902.2 05:25:19 INFO - PROCESS | 31298 | 05:25:19 INFO - PROCESS | 31298 | [#5] yui.html Cycles:180 Average:16307.11 Median:4323.63 stddev:19228.43 (444.7%) stddev-sans-first:19247.04 05:25:19 INFO - PROCESS | 31298 | Values: 784.6 793.5 804.9 869.5 901.7 14714.9 15550.7 15638.5 15682.2 15684.4 14672.9 14918.8 14923.5 14937.9 14940.0 684.8 819.5 841.7 845.3 857.1 835.1 840.3 842.2 842.3 844.1 898.2 899.8 903.6 903.6 904.1 898.3 898.7 899.2 902.0 903.9 641.4 644.0 645.1 649.0 649.8 14699.9 14729.6 14759.7 14809.0 14838.9 14624.2 14750.8 14858.0 14861.4 14966.8 11982.9 11987.2 12091.2 12132.6 12162.9 3895.3 3910.7 3917.8 3942.0 4033.4 60970.0 61594.4 61637.7 62122.0 62215.0 10706.0 10706.6 10811.2 10968.5 10997.9 19087.0 19431.9 21266.9 21281.3 21403.4 8652.5 8709.5 8725.3 8802.8 8849.8 4850.7 4903.6 4903.6 5023.6 5145.4 3349.5 3406.5 3424.3 3428.4 3436.3 608.2 612.4 615.7 638.7 663.8 738.8 788.4 805.0 806.8 832.1 9707.7 9972.0 9990.5 10024.7 10062.0 662.7 742.4 765.2 785.0 793.9 4613.8 4896.1 4926.4 5022.8 5076.1 61166.4 69038.0 69895.7 69962.7 70212.0 56553.7 61306.7 61795.7 61947.4 62285.0 58330.7 58573.7 58648.4 58682.7 58939.4 9868.7 10026.3 10155.5 10157.5 10305.5 37077.3 37155.3 38261.6 38507.4 38841.0 50378.2 50793.5 50934.0 51634.5 51834.7 13154.9 13350.9 13412.5 13418.5 13438.5 13992.8 14300.6 14784.3 14796.0 14937.2 13537.1 13600.5 13730.5 13894.7 14065.2 13261.1 13561.3 13667.5 13681.2 13722.3 13242.2 13253.9 13436.5 13456.1 13587.9 11371.7 11460.6 11752.1 11954.4 12374.9 11638.8 11758.2 11991.2 12085.5 12111.8 05:25:19 INFO - PROCESS | 31298 | -------- Summary: end -------- 05:25:19 INFO - PROCESS | 31298 | 05:25:19 INFO - TEST-INFO | 31298: exit 0 05:25:19 INFO - TEST-OK | dromaeo_css | took 1109903ms 05:25:19 INFO - TEST-START | kraken 05:25:19 INFO - operating with platform_type : linux_ 05:25:19 INFO - Initialising browser for kraken test... 05:25:19 INFO - TEST-INFO | started process 31534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmw2dgC/profile http://localhost:47625/getInfo.html) 05:25:23 INFO - PROCESS | 31534 | 05:25:23 INFO - PROCESS | 31534 | (process:31606): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:25:24 INFO - PROCESS | 31534 | __metrics Screen width/height:1600/1200 05:25:24 INFO - PROCESS | 31534 | colorDepth:24 05:25:24 INFO - PROCESS | 31534 | Browser inner width/height: 1024/697 05:25:24 INFO - PROCESS | 31534 | __metrics 05:25:25 ERROR - PROCESS | 31534 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:25:26 INFO - TEST-INFO | 31534: exit 0 05:25:26 INFO - Browser initialized. 05:25:26 INFO - Running cycle 1/1 for kraken test... 05:25:26 INFO - TEST-INFO | started process 31657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmw2dgC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:27 INFO - PROCESS | 31657 | 05:25:27 INFO - PROCESS | 31657 | (process:31717): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:25:37 INFO - PROCESS | 31657 | RSS: Main: 163450880 05:25:37 INFO - PROCESS | 31657 | 05:25:40 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47625/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:41 INFO - PROCESS | 31657 | RSS: Main: 168058880 05:25:41 INFO - PROCESS | 31657 | 05:25:44 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47625/tests/kraken/driver.html?testName=audio-dft) 05:25:44 INFO - PROCESS | 31657 | RSS: Main: 168210432 05:25:44 INFO - PROCESS | 31657 | 05:25:47 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47625/tests/kraken/driver.html?testName=audio-fft) 05:25:48 INFO - PROCESS | 31657 | RSS: Main: 163094528 05:25:48 INFO - PROCESS | 31657 | 05:25:50 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47625/tests/kraken/driver.html?testName=audio-oscillator) 05:25:51 INFO - PROCESS | 31657 | RSS: Main: 163164160 05:25:51 INFO - PROCESS | 31657 | 05:25:53 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:25:53 INFO - PROCESS | 31657 | RSS: Main: 163479552 05:25:53 INFO - PROCESS | 31657 | 05:25:57 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47625/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:57 INFO - PROCESS | 31657 | RSS: Main: 163872768 05:25:57 INFO - PROCESS | 31657 | 05:26:01 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47625/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:01 INFO - PROCESS | 31657 | RSS: Main: 162267136 05:26:01 INFO - PROCESS | 31657 | 05:26:04 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47625/tests/kraken/driver.html?testName=json-parse-financial) 05:26:05 INFO - PROCESS | 31657 | RSS: Main: 163119104 05:26:05 INFO - PROCESS | 31657 | 05:26:07 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:07 INFO - PROCESS | 31657 | RSS: Main: 164417536 05:26:07 INFO - PROCESS | 31657 | 05:26:09 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:10 INFO - PROCESS | 31657 | RSS: Main: 164773888 05:26:10 INFO - PROCESS | 31657 | 05:26:12 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:12 INFO - PROCESS | 31657 | RSS: Main: 164167680 05:26:12 INFO - PROCESS | 31657 | 05:26:15 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:16 INFO - PROCESS | 31657 | RSS: Main: 164651008 05:26:16 INFO - PROCESS | 31657 | 05:26:18 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:19 INFO - PROCESS | 31657 | RSS: Main: 164904960 05:26:19 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47625/tests/kraken/driver.html?testName=ai-astar) 05:26:21 INFO - PROCESS | 31657 | RSS: Main: 165974016 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | __start_tp_report 05:26:21 INFO - PROCESS | 31657 | _x_x_mozilla_page_load 05:26:21 INFO - PROCESS | 31657 | _x_x_mozilla_page_load_details 05:26:21 INFO - PROCESS | 31657 | |i|pagename|runs| 05:26:21 INFO - PROCESS | 31657 | |0;ai-astar;108;110;105;111;109;113;105;109;110;110 05:26:21 INFO - PROCESS | 31657 | |1;audio-beat-detection;151;126;161;209;133;154;156;133;181;125 05:26:21 INFO - PROCESS | 31657 | |2;audio-dft;162;162;162;161;165;168;166;163;161;163 05:26:21 INFO - PROCESS | 31657 | |3;audio-fft;75;76;81;157;76;76;75;76;172;75 05:26:21 INFO - PROCESS | 31657 | |4;audio-oscillator;91;92;182;93;91;91;148;91;93;156 05:26:21 INFO - PROCESS | 31657 | |5;imaging-gaussian-blur;117;118;117;116;117;117;118;117;118;118 05:26:21 INFO - PROCESS | 31657 | |6;imaging-darkroom;146;147;147;148;148;146;147;146;147;146 05:26:21 INFO - PROCESS | 31657 | |7;imaging-desaturate;96;95;95;95;96;96;95;95;96;95 05:26:21 INFO - PROCESS | 31657 | |8;json-parse-financial;57;55;54;55;60;54;57;105;52;52 05:26:21 INFO - PROCESS | 31657 | |9;json-stringify-tinderbox;59;59;59;60;60;58;59;60;60;59 05:26:21 INFO - PROCESS | 31657 | |10;stanford-crypto-aes;81;82;78;79;84;83;81;83;79;79 05:26:21 INFO - PROCESS | 31657 | |11;stanford-crypto-ccm;121;128;120;136;130;126;121;120;186;134 05:26:21 INFO - PROCESS | 31657 | |12;stanford-crypto-pbkdf2;164;161;162;166;160;157;159;158;160;161 05:26:21 INFO - PROCESS | 31657 | |13;stanford-crypto-sha256-iterative;63;63;65;63;62;62;63;65;67;62 05:26:21 INFO - PROCESS | 31657 | __end_tp_report 05:26:21 INFO - PROCESS | 31657 | __start_cc_report 05:26:21 INFO - PROCESS | 31657 | _x_x_mozilla_cycle_collect,848 05:26:21 INFO - PROCESS | 31657 | __end_cc_report 05:26:21 INFO - PROCESS | 31657 | __startTimestamp1463401581499__endTimestamp 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | ------- Summary: start ------- 05:26:21 INFO - PROCESS | 31657 | Number of tests: 14 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.49 (2.3%) stddev-sans-first:2.62 05:26:21 INFO - PROCESS | 31657 | Values: 108.0 110.0 105.0 111.0 109.0 113.0 105.0 109.0 110.0 110.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:155.00 stddev:26.48 (17.1%) stddev-sans-first:28.08 05:26:21 INFO - PROCESS | 31657 | Values: 151.0 126.0 161.0 209.0 133.0 154.0 156.0 133.0 181.0 125.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.31 (1.4%) stddev-sans-first:2.40 05:26:21 INFO - PROCESS | 31657 | Values: 162.0 162.0 162.0 161.0 165.0 168.0 166.0 163.0 161.0 163.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.42 (49.2%) stddev-sans-first:39.06 05:26:21 INFO - PROCESS | 31657 | Values: 75.0 76.0 81.0 157.0 76.0 76.0 75.0 76.0 172.0 75.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:91.00 stddev:34.98 (38.4%) stddev-sans-first:36.20 05:26:21 INFO - PROCESS | 31657 | Values: 91.0 92.0 182.0 93.0 91.0 91.0 148.0 91.0 93.0 156.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:26:21 INFO - PROCESS | 31657 | Values: 117.0 118.0 117.0 116.0 117.0 117.0 118.0 117.0 118.0 118.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 05:26:21 INFO - PROCESS | 31657 | Values: 146.0 147.0 147.0 148.0 148.0 146.0 147.0 146.0 147.0 146.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:26:21 INFO - PROCESS | 31657 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:55.00 stddev:15.96 (29.0%) stddev-sans-first:16.89 05:26:21 INFO - PROCESS | 31657 | Values: 57.0 55.0 54.0 55.0 60.0 54.0 57.0 105.0 52.0 52.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 05:26:21 INFO - PROCESS | 31657 | Values: 59.0 59.0 59.0 60.0 60.0 58.0 59.0 60.0 60.0 59.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.50 stddev:2.08 (2.6%) stddev-sans-first:2.20 05:26:21 INFO - PROCESS | 31657 | Values: 81.0 82.0 78.0 79.0 84.0 83.0 81.0 83.0 79.0 79.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:129.00 stddev:19.78 (15.3%) stddev-sans-first:20.56 05:26:21 INFO - PROCESS | 31657 | Values: 121.0 128.0 120.0 136.0 130.0 126.0 121.0 120.0 186.0 134.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:2.70 (1.7%) stddev-sans-first:2.60 05:26:21 INFO - PROCESS | 31657 | Values: 164.0 161.0 162.0 166.0 160.0 157.0 159.0 158.0 160.0 161.0 05:26:21 INFO - PROCESS | 31657 | 05:26:21 INFO - PROCESS | 31657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:1.65 (2.6%) stddev-sans-first:1.74 05:26:21 INFO - PROCESS | 31657 | Values: 63.0 63.0 65.0 63.0 62.0 62.0 63.0 65.0 67.0 62.0 05:26:21 INFO - PROCESS | 31657 | -------- Summary: end -------- 05:26:21 INFO - PROCESS | 31657 | 05:26:22 INFO - TEST-INFO | 31657: exit 0 05:26:22 INFO - TEST-OK | kraken | took 62537ms 05:26:22 INFO - SUITE-END | took 1172s 05:26:22 INFO - Completed test suite (00:19:32) 05:26:22 INFO - javascript benchmark 05:26:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7297.0867404468845, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.8905938292155, 3222.258880457495, 3243.4323993301173, 3259.3318369734206, 3278.7049165575095, 5442.238086667865, 5487.98472282628, 5554.250176226208, 5573.526250268732, 5578.832635020955, 5286.497782710646, 5458.1266997280445, 5465.508104270615, 5470.507654311111, 5557.055300598898, 4923.18767403378, 4952.380952380952, 5098.133317336062, 5107.7701503432245, 5164.354455693038, 628.3669129252406, 5051.267566202899, 5052.292679024939, 5129.358830146231, 5160.56135228506, 5003.424606170264, 5019.598432125439, 5030.119729047402, 5032.521910418523, 5070.670406423589, 4985.725785081819, 5025.547700706954, 5040.14317566011, 5051.4695956924725, 5051.570616497602, 4969.776360063805, 5026.220935754964, 5035.269885866565, 5046.0, 5095.847124586268, 5420.485053919911, 5431.565474762009, 5460.044492213887, 5488.313960754906, 5500.532454741352, 5605.131204663284, 5919.911201331984, 5942.70286485674, 5948.881022379572, 5950.523958083386, 5961.791337303217, 6009.489193418564, 6011.398860113997, 6011.458968692838, 6040.8187754367, 5583.078791999355, 5585.609007369486, 5593.804216852391, 5594.776208951637, 5598.3282006159525, 5708.743106560215, 6014.458698717136, 6063.848403789941, 6091.543134264948, 6104.511639068864, 5837.416258374129, 5851.765929362778, 5858.238429004202, 5889.322727886262, 5929.555283353766, 5907.05487122067, 5930.703464826742, 5938.317093534212, 5941.197938278364, 5967.910481342783, 5598.748056337475, 5793.913091303634, 5842.5618078644275, 5850.0932355484965, 5888.617239879394, 5607.158926161027, 5772.6536407815665, 5822.7088645567555, 5879.20630714848, 5891.3224979127945, 4397.934030989538, 4399.6040356368085, 4403.757793321334, 4430.601245887886, 4457.799399027052, 3897.0841852165286, 3961.267165574378, 3966.167104907944, 3975.582563830756, 4003.619656132663, 5641.069223578063, 5651.208830763697, 5652.519535839418, 5655.519280861173, 5669.40471250521, 5846.6784326862435, 5948.434898684618, 5955.28536575605, 5964.761409543569, 5993.61041532299, 5419.864503387447, 5620.100783874561, 5650.124230744241, 5686.2039314496005, 5696.515796157373, 4910.8772280693265, 4914.238293064581, 4917.164082106051, 4931.556159945622, 4931.753412329441, 5889.882202355929, 6079.544034197453, 6122.816315510542, 6152.077188421773, 6152.692365381713, 5876.559258055578, 5884.941150588439, 5923.229980102559, 5924.407559244041, 5946.316173640087, 6104.175936248727, 6121.724522396414, 6124.173236613, 6132.724027418688, 6141.508679305555, 5571.9442805571425, 5780.21967034445, 5799.362070172362, 5799.536037116936, 5806.65160090396, 5967.791127310524, 5996.580239383201, 5998.8500287491415, 6003.2796064470795, 6020.4280593343565, 5755.482006619424, 5815.76736930518, 5828.096645019859, 5835.970820146042, 5844.26946631671, 5474.2609747683555, 5664.631798933056, 5794.913076303943, 5839.562032847469, 5846.795362162304, 5405.054115529688, 5638.943610564006, 5640.097584386478, 5648.971755141198, 5738.9139162913425, 5700.629459085146, 5791.565632577658, 5799.4780469757925, 5828.6502809831545, 5840.123981402823, 5439.728013599225, 5656.406077361818, 5715.457031581993, 5731.799387021434, 5737.713114344183], "value": 5402.746494800792, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.7950496831077, 628.8302158417227, 634.235745926159, 645.8482256669685, 653.9607623542588, 43271.78364108179, 44180.558194418045, 44262.557374426244, 44268.55731442685, 47252.52747472524, 45055.549444505545, 45538.544614553844, 45722.771386143104, 45756.0, 46046.53953460464, 9011.639534418631, 9099.818003639923, 9139.314551408637, 9144.679936202234, 9152.4966126863, 8892.24415924644, 8949.373543851932, 9002.054784247657, 9024.77438064047, 9035.141661542177, 9027.593758280893, 9034.277257819358, 9068.229200517964, 9075.319351048698, 9099.408538445014, 8970.730878073668, 8991.460512369278, 9030.86453703195, 9046.77383065422, 9051.502167380824, 8923.41997770143, 9009.864852027225, 9030.367874248805, 9052.547372631341, 9061.275097992146, 41258.58741412607, 41518.0, 41561.79219103915, 41591.37612935808, 41597.79201103975, 3738.2897249522503, 3768.171002379472, 3779.433085037266, 3888.727789054739, 3905.1213476967737, 32503.837480812683, 32930.67069329324, 33148.34258287076, 35192.64807351945, 35253.29493410118, 4107.609777071173, 4177.937330940038, 4264.0832221072305, 4274.615284624368, 4339.1972485090355, 378684.0, 380405.0, 381593.0, 382847.0, 384769.0, 62048.06927896085, 62532.68733656302, 62658.0, 62896.0, 62932.05601915975, 36533.26933461316, 37411.25177496489, 37436.43845342322, 66054.66972665106, 66279.0, 16147.434839780552, 16151.273192706356, 16229.675406491804, 16247.59381015484, 16291.918540407221, 12555.435005424777, 12690.555830545887, 12753.171043882117, 12761.68095797594, 12774.489020439078, 19913.701294480594, 19974.70037949432, 20032.098555565033, 20036.298729544396, 20165.58013038445, 7299.817504562428, 7374.594397308092, 7598.658060387296, 7682.193369696213, 7827.608619568999, 988.1995583577325, 1078.6386560502162, 1132.9180632495948, 1201.6755476021426, 1226.8527776666856, 31076.0, 31637.20906977298, 31761.0, 31895.681043189736, 31926.361472770415, 1159.6694941941676, 1191.386435985468, 1198.6523908066738, 1259.6724851538484, 1274.6176147156002, 16671.249793759067, 17242.224099915533, 17298.740518892228, 17302.134893255286, 17421.128943553023, 547051.0, 558121.0, 559151.0, 559215.0, 560935.0, 58456.70771646115, 59170.704146478995, 59367.40632593705, 59475.70262148748, 59477.107843382386, 1411.484808045056, 1435.777454494555, 1442.3653592419303, 1464.1946929189116, 1464.3410465290663, 30175.69824301729, 30669.866026794283, 31254.843725781226, 31492.37015259728, 31707.0, 50883.236751448014, 50926.0, 51079.48920510896, 51208.0, 51293.230601541756, 353813.0, 354465.0, 355151.0, 357081.0, 358722.06389680936, 28116.613323261103, 28868.0, 29008.0, 29269.0, 29278.56082158812, 47945.280820788415, 48087.5191248097, 49103.26345104898, 49289.50710492849, 49477.50522494729, 40475.39286910758, 41329.58670413378, 42053.0, 42189.1562168761, 42742.78628606837, 40050.1989960205, 40862.18275634411, 40889.0, 42198.78900605477, 42358.36462453127, 41541.37687934623, 42518.14963700647, 43879.0, 44182.11635767331, 46020.539794601624, 36740.44889326609, 36938.63061369459, 37179.0, 38033.61966380301, 38061.80969095137, 28996.130116096552, 29229.0, 29338.266543335732, 29519.409611807216, 29696.851515742284], "value": 20437.12956475786, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.7053439386067, 397.52495767557764, 408.0451742921563, 410.3475473996345, 412.13040484577516, 13717.176969381819, 18128.90935545322, 18739.0, 19660.410187694375, 19823.10796014179, 18603.348882789105, 18845.43463696088, 19195.23219071239, 19287.710684339745, 19482.805171948312, 5504.2294078829, 5603.103503439461, 5716.59983801132, 5730.197772311859, 5791.333996590382, 5602.13166959122, 5618.634788738739, 5653.067243904771, 5655.971720141414, 5666.3766985631755, 5469.179623056533, 5623.718814059301, 5787.710614469281, 5846.561507886904, 5883.970580147094, 5746.770129194827, 5797.681127537984, 5827.941720582782, 5852.941470585303, 5854.121881717734, 4927.77824997876, 5039.647224694273, 5045.041442125985, 5069.264956581312, 5069.822556210552, 21504.56990860174, 21907.780922190894, 22511.32466026022, 22543.0, 22567.210147644917, 2241.3612120545567, 2609.4389706213065, 2716.4838680650614, 2789.7210278972143, 2792.287966568512, 10416.27086103973, 10439.53022113999, 10540.472976351228, 10690.51892664832, 10750.623728169476, 1975.224978324347, 2060.485870104115, 2079.625667379871, 2095.8218551422997, 2121.6287149748887, 77668.61165694136, 80433.79349309823, 81302.0, 82623.5868820658, 83074.58462707709, 10772.084372828398, 10834.62078827253, 10952.945235273774, 11080.889191108146, 11144.498497567629, 15482.30329635169, 15578.376864925503, 15599.142047187286, 15618.3752649895, 15637.061776293458, 8181.918180818235, 8259.21537453941, 8339.332853371716, 8355.340229930625, 8506.702265420681, 8297.875531867026, 8357.8328433431, 8376.706815261437, 8462.576871156542, 8503.107173746792, 4714.151452738472, 4793.856184314476, 4911.508849115131, 4927.285543596158, 4939.036887806915, 1982.1873032056787, 1998.4704053425853, 2000.3898810862827, 2014.587009663045, 2033.4509682385674, 972.3825370889394, 1049.7113293844254, 1055.382601178304, 1066.6001496632578, 1073.0878753059992, 18062.36781712634, 18257.908710456362, 18896.244150233837, 18915.0, 19168.0, 1057.7937302225992, 1084.978300433987, 1094.480121942087, 1099.9715266226103, 1100.8458815765798, 8028.0, 10663.946680266705, 10705.250632455653, 10778.4071876046, 10833.512491937881, 491326.1892159075, 495559.0, 501160.0, 503399.0, 504645.0, 72099.27900720926, 84100.0, 85576.57211713902, 88406.55796721103, 93053.5347323259, 1071.4160782373624, 1085.8045551800594, 1123.7303047268597, 1151.8675352334421, 1159.9826002609968, 17010.149492525572, 17020.262690241627, 17085.402010929556, 17202.65594688124, 17231.655366892843, 40390.59609403869, 40989.0, 41010.384844227956, 41083.0, 41580.376294355, 55876.0, 57895.71052144712, 57975.42024579869, 58093.4190658088, 58125.418745813695, 8365.539895305817, 8383.832323353377, 8493.490390576339, 8702.869456958277, 8712.69505567302, 10205.367141257364, 12948.0, 13117.278549679859, 13244.271565064015, 13629.591112266648, 9030.645403189574, 11873.465694043962, 11885.881141188478, 11913.940430297793, 12027.338496382434, 11289.322640641587, 11367.488463019019, 11527.193096483166, 11602.563461673144, 11658.94170529142, 11445.427728613702, 11551.88448115508, 11739.882601173878, 11900.642980710592, 12147.210431321935, 7517.097948246245, 8346.66613335484, 8459.111793261618, 8642.481451112953, 8918.554072296229, 10559.788804224027, 11799.17405781587, 12383.442745076673, 12433.689157771129, 12602.810957835456], "value": 9253.340998137091, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.2204053891974, 1558.2831897327228, 1696.541933677907, 1845.4463660901727, 1846.0769615192412, 7565.0, 8582.656693732244, 8622.482651040935, 9064.365494415386, 9143.268538516912, 8630.395872288942, 8910.688125915594, 8988.370814043019, 8991.370604057718, 9013.81972360554, 2331.743508214099, 2346.85918844869, 2355.6702061711376, 2366.7869891709743, 2374.8100151987887, 2329.219711396684, 2368.111958015744, 2369.218158007853, 2376.0733314007553, 2379.167291447988, 2354.6468029795496, 2356.163561935514, 2381.84518006329, 2394.174009966559, 2401.8799060047013, 2288.3249441414823, 2299.3906614747107, 2307.1117619716447, 2319.373769082355, 2328.406256404623, 2293.323469576479, 2310.099061366052, 2324.639680849471, 2326.4649130699863, 2328.848624839397, 8964.282857371394, 8982.730518084469, 8992.77518062047, 9003.5048072356, 9013.324000699973, 5187.195984622352, 5416.864578385533, 5422.105352616813, 5436.2661040759385, 5478.45215478453, 3298.2743796365003, 3299.1257316811066, 3344.882929097494, 3386.4920261960656, 3395.1002984209204, 1123.8258069999163, 1143.2911594811187, 1148.9942550287194, 1161.117550661495, 1192.248883203585, 12208.26750394988, 12218.450169742382, 12251.571195008131, 12286.262824230485, 12380.690482737913, 4656.278276867091, 4737.881552961204, 4756.5956893664425, 4772.045590881838, 4828.37231159947, 10515.158787296998, 10542.947285263524, 10542.947285263524, 10551.366917984946, 10574.154067674568, 5344.171653393731, 5363.731813409314, 5373.946260537423, 5377.650452720561, 5387.164989426645, 4470.731756094645, 4775.6657034007985, 4974.204127339681, 4980.601551875841, 5004.199328107486, 3915.0, 4026.939595906064, 4111.218868414991, 4129.802357316345, 4148.398482220061, 1270.9809352859716, 1283.62133170713, 1294.2816736711027, 1302.3358087375507, 1326.7678156322604, 1012.1902478017556, 1015.8730158730159, 1035.534009695625, 1041.354360296621, 1048.7430579507916, 5789.652620842763, 5807.738651760681, 5895.380984996514, 6058.0610005449225, 6073.726682299307, 448.4148186616497, 456.99543004570194, 458.3903408466798, 462.4727810296265, 464.9721016739006, 4283.764392958355, 4307.6769242306955, 4321.416608757841, 4321.611055005064, 4356.150550642657, 10827.133829293794, 11073.05879000294, 11078.279911805706, 11088.22382433238, 11110.50002749862, 10898.618548350769, 10901.073408760185, 10953.288036277616, 10959.890401096047, 11017.779644407066, 7755.806104847424, 8102.189781021851, 8105.55419451924, 8316.085230624505, 8319.66721331152, 6024.096385542204, 6188.690565471618, 6239.438450539473, 6246.187995560548, 6371.362863713777, 9869.272877246596, 10165.79668406613, 10191.643292484727, 10249.538770755185, 10335.069843713802, 10419.374837509773, 10449.0, 10469.110125639101, 10531.210159237935, 10553.155747540332, 7651.808704782202, 7735.419843511647, 7803.180666029985, 7914.881276780968, 7930.682772689028, 8397.748067557983, 8418.368622353226, 8427.705030323908, 8427.8735818964, 8491.405601607828, 7353.080864891888, 7508.662110204945, 7686.07767067933, 7725.690972361042, 7856.332211761835, 7626.237376262329, 7648.464607477423, 7663.8850417242675, 7828.608569571385, 7828.960855195687, 7118.216996130318, 7122.928770712227, 7185.964070179615, 7194.712211511481, 7199.2440793715905, 4960.131976904099, 5085.720285384339, 5098.2352647103235, 5110.48895110486, 5133.820316289061, 5224.686518808883, 5369.328833895763, 5381.838544843661, 5414.675119492843, 5465.562754979672], "value": 4622.102843852558, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.10630772253876, 341.3412114618786, 344.9775764575302, 348.6182630020127, 350.3850741947881, 5548.4174161713045, 5599.3403133511665, 5656.971715141429, 5769.221155144054, 5775.480206781394, 5604.523615492688, 5623.0721930881355, 5626.578006649497, 5643.492085712285, 5657.801976930808, 4310.224159651261, 4363.912721745563, 4391.604755571998, 4406.228909940747, 4409.779511024436, 4114.280000999813, 4313.741175529462, 4365.388845561624, 4388.824447022132, 4394.956050439503, 4311.741295522263, 4318.740875547462, 4334.5448727883595, 4334.97832510837, 4339.674524410666, 4366.912661746763, 4394.143142087294, 4398.208322501949, 4399.306267087194, 4401.339799030139, 3800.619938006205, 3830.0616348994677, 3893.3186692329014, 3893.98053009736, 3895.0846551060763, 5392.923724366108, 5413.242146099549, 5425.131978883399, 5430.83707488776, 5480.136753503828, 4933.777979990909, 4949.455559888409, 4950.628702847301, 4961.231009193581, 4966.304717339575, 5782.219400380936, 5817.56368272377, 5833.7958171464215, 5862.560307976876, 5877.676727780014, 4170.727927981964, 4177.665786737084, 4191.517975432834, 4223.493180818322, 4238.152369526107, 6105.633661980251, 6115.908261376083, 6159.3224745277985, 6180.629162250234, 6191.907121393183, 4180.226658068206, 4231.174920890458, 4254.468191476066, 4292.785360732013, 4303.591158839905, 4325.43769309994, 4350.282203436397, 4360.41134446852, 4368.737875727466, 4386.298192289219, 4972.563443912529, 4993.625478089158, 5000.749812546864, 5001.824936127218, 5022.723750193702, 5664.51851592611, 5886.470217680429, 5899.528037756969, 5923.289205295392, 5950.7917222896995, 1473.197107576352, 1503.6541595432893, 1505.4429860951518, 1508.751056075757, 1513.1148278257124, 926.6710317837205, 951.533748463248, 962.6678795815433, 964.0118878149813, 972.7840199750312, 5028.19548872186, 5046.26829109777, 5058.620603454756, 5075.3148324975655, 5107.442230119775, 5280.313559237351, 5398.973005134949, 5420.728963551806, 5426.635485998706, 5464.508194262536, 4921.335619691367, 4936.778610543537, 5078.0, 5114.232865070269, 5116.516210298972, 2896.7399181356177, 2898.7680985521106, 2905.5060639691305, 2915.3877685686243, 2916.460454815866, 5471.589630777628, 5482.533984611273, 5489.286392768914, 5541.5289700375915, 5554.444555544414, 5397.460253974571, 5733.770649173986, 6195.0, 6220.875582488325, 6229.626222426669, 6323.9051414228825, 6353.141086511088, 6355.555111142268, 6370.235571731329, 6413.935860641427, 5922.674252916131, 6024.277086749618, 6099.4815440688035, 6106.542009349228, 6141.416565426277, 5963.821085367446, 6046.183765191819, 6056.212692349966, 6062.272527296576, 6068.4538391544975, 5947.375525569752, 5976.731047102804, 6345.96827015862, 6357.618542887441, 6362.363763623601, 4304.246756817607, 4322.610965013164, 4323.54602766705, 4342.41377414045, 4353.542877997765, 6126.23422072241, 6148.877022459616, 6186.226721659793, 6188.845278868064, 6202.34875338083, 5654.802081927113, 5921.3190483094995, 5925.200097986716, 5934.902043121863, 5942.673152976455, 5890.852728681817, 5910.408959104056, 5920.200772895604, 5924.733386997682, 5955.255593050869, 5629.860652951852, 5778.855528611818, 5844.912326315024, 5874.853128671646, 5883.646981181143, 5836.737346819318, 5839.299284085937, 5953.10703394477, 5978.671173085522, 5980.9401905980385, 5857.941420585739, 5864.120381942743, 5879.647221166743, 5887.999040163097, 5902.1736956826935], "value": 4419.289776872433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.6429874407145, 793.468376187954, 804.9476784009042, 869.465278853505, 901.7384958362076, 14714.926425367872, 15550.688986220282, 15638.452654157107, 15682.21588920555, 15684.372625094997, 14672.853271467282, 14918.776218356734, 14923.477678281262, 14937.850621493782, 14940.0, 684.8322161070532, 819.4673462249526, 841.6507149532937, 845.285733555148, 857.087202129733, 835.1022650650575, 840.3403328387217, 842.1957031035378, 842.3303473738392, 844.1136806353335, 898.2185498616213, 899.8065415935572, 903.575319599787, 903.5978989349709, 904.0507467159489, 898.3352319283715, 898.6674930275807, 899.2086963472168, 902.0483390023522, 903.9457632542036, 641.413107007088, 643.9581427207216, 645.1484041065795, 648.9578177418452, 649.8018104478132, 14699.92650036743, 14729.631759205999, 14759.704805903822, 14809.0, 14838.851611483855, 14624.195669238188, 14750.778738318933, 14858.0, 14861.405543778235, 14966.775498367424, 11982.880171198263, 11987.160898737093, 12091.214071085351, 12132.575359862363, 12162.878371216351, 3895.2988462076814, 3910.7262491625597, 3917.784521851297, 3941.980290098531, 4033.4151548025666, 60970.0, 61594.38405615931, 61637.6918115411, 62122.0, 62214.99999999955, 10706.0, 10706.625268115578, 10811.243212975016, 10968.451577421098, 10997.890021099687, 19087.0, 19431.90284048599, 21266.893665531574, 21281.255156069463, 21403.357899263046, 8652.524111173945, 8709.520976346235, 8725.301975841918, 8802.823943521222, 8849.778755531162, 4850.684705494202, 4903.632227582945, 4903.632227582945, 5023.648344615842, 5145.408278048072, 3349.480830471281, 3406.523086767805, 3424.280901010816, 3428.400029994741, 3436.3127374525193, 608.2457752387008, 612.4273803993192, 615.7106160104744, 638.6615094000188, 663.7743167323133, 738.7525179064966, 788.4047544104164, 804.951702897828, 806.8345989072226, 832.142892820396, 9707.708768736808, 9971.950140249397, 9990.500474976223, 10024.749381265527, 10062.0, 662.6786008785735, 742.4023660952985, 765.2385876053363, 784.9725259615886, 793.9444238903337, 4613.8385156520035, 4896.094222568836, 4926.432801640462, 5022.84931452057, 5076.086304465158, 61166.38833611607, 69038.0, 69895.65052174809, 69962.65018674976, 70212.0, 56553.71723141358, 61306.69346653238, 61795.691021544604, 61947.38052619506, 62285.0, 58330.708346458, 58573.70713146407, 58648.4135158643, 58682.7065864668, 58939.41060589425, 9868.660981470646, 10026.348287361297, 10155.492225388849, 10157.542910568895, 10305.53625086888, 37077.258454831295, 37155.25689486249, 38261.617383825804, 38507.42238866363, 38841.0, 50378.244326335865, 50793.492065080354, 50933.98132037413, 51634.48365516297, 51834.74082629714, 13154.868451315364, 13350.9332453341, 13412.530561430303, 13418.530351437652, 13438.46246150143, 13992.790108148183, 14300.570982870531, 14784.33470493852, 14796.0, 14937.178455185069, 13537.1200871943, 13600.455981761015, 13730.45078196861, 13894.652633684238, 14065.156090634595, 13261.138026028277, 13561.254131022888, 13667.453301868212, 13681.179129252278, 13722.313884305944, 13242.20546767197, 13253.933730331286, 13436.462541498231, 13456.058075934981, 13587.932060339635, 11371.658850234506, 11460.598879039193, 11752.087947009331, 11954.402279885797, 12374.876251237372, 11638.825417618573, 11758.176927614984, 11991.160618756603, 12085.51657933708, 12111.75776484483], "value": 7233.161772370786, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 105.0, 111.0, 109.0, 113.0, 105.0, 109.0, 110.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 161.0, 209.0, 133.0, 154.0, 156.0, 133.0, 181.0, 125.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 165.0, 168.0, 166.0, 163.0, 161.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 81.0, 157.0, 76.0, 76.0, 75.0, 76.0, 172.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 182.0, 93.0, 91.0, 91.0, 148.0, 91.0, 93.0, 156.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 55.0, 60.0, 54.0, 57.0, 105.0, 52.0, 52.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 58.0, 59.0, 60.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 78.0, 79.0, 84.0, 83.0, 81.0, 83.0, 79.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 128.0, 120.0, 136.0, 130.0, 126.0, 121.0, 120.0, 186.0, 134.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 166.0, 160.0, 157.0, 159.0, 158.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 63.0, 62.0, 62.0, 63.0, 65.0, 67.0, 62.0], "value": 63.5, "unit": "score"}]}]} 05:26:22 INFO - Return code: 0 05:26:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:26:22 ERROR - # TBPL SUCCESS # 05:26:22 INFO - Running post-action listener: _resource_record_post_action 05:26:22 INFO - ##### 05:26:22 INFO - ##### Finished run-tests step (success) 05:26:22 INFO - ##### 05:26:22 INFO - Running post-run listener: _resource_record_post_run 05:26:22 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 535912448; Read time: 132; Write time: 631060 05:26:22 INFO - TinderboxPrint: CPU usage
13.4% 05:26:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 132 05:26:22 INFO - TinderboxPrint: I/O write bytes / time
535,912,448 / 631,060 05:26:22 INFO - TinderboxPrint: CPU idle
8,220.3 (86.6%) 05:26:22 INFO - TinderboxPrint: CPU user
1,215.2 (12.8%) 05:26:22 INFO - TinderboxPrint: Swap in / out
0 / 0 05:26:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246341632; Read time: 0; Write time: 361024 05:26:22 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289570816; Read time: 132; Write time: 270036 05:26:23 INFO - Running post-run listener: _upload_blobber_files 05:26:23 INFO - Blob upload gear active. 05:26:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:23 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 05:26:23 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'] 05:26:23 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 05:26:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:24 INFO - (blobuploader) - INFO - Done attempting. 05:26:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:26:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:32 INFO - (blobuploader) - INFO - Done attempting. 05:26:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:26:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:32 INFO - (blobuploader) - INFO - Done attempting. 05:26:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:32 INFO - Return code: 0 05:26:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50bd7612f0cdc8d43d3eacf0ac055894d573642118344137d9af35975bd100ae8a5ba37d370727fffd23927c3edd185d7faa0f1406f74ad85f69bbf534337474", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2100ba9bef4a83ca52cc740dd79319a285c96abeb8f673e211548425cd68831b3a2784a09e14cccf24a0cb621391fe7eb110f03f8e4a4c2a7a0537a990e81c47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ce5a054e6e1c4e573fee21e8c5b28d987b463f3174020088985317da9af41f696914cfa280fa6cb332d13aa2c5e3148d82e09588cb8dc7aa9a41fa31ddb80ed"} 05:26:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:32 INFO - Contents: 05:26:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50bd7612f0cdc8d43d3eacf0ac055894d573642118344137d9af35975bd100ae8a5ba37d370727fffd23927c3edd185d7faa0f1406f74ad85f69bbf534337474", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2100ba9bef4a83ca52cc740dd79319a285c96abeb8f673e211548425cd68831b3a2784a09e14cccf24a0cb621391fe7eb110f03f8e4a4c2a7a0537a990e81c47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ce5a054e6e1c4e573fee21e8c5b28d987b463f3174020088985317da9af41f696914cfa280fa6cb332d13aa2c5e3148d82e09588cb8dc7aa9a41fa31ddb80ed"} 05:26:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:32 INFO - Copying logs to upload dir... 05:26:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.840349 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-16 05:26:32.552028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 05:26:32.555213) ========= 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=aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997 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/50bd7612f0cdc8d43d3eacf0ac055894d573642118344137d9af35975bd100ae8a5ba37d370727fffd23927c3edd185d7faa0f1406f74ad85f69bbf534337474", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2100ba9bef4a83ca52cc740dd79319a285c96abeb8f673e211548425cd68831b3a2784a09e14cccf24a0cb621391fe7eb110f03f8e4a4c2a7a0537a990e81c47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ce5a054e6e1c4e573fee21e8c5b28d987b463f3174020088985317da9af41f696914cfa280fa6cb332d13aa2c5e3148d82e09588cb8dc7aa9a41fa31ddb80ed"} build_url:https://queue.taskcluster.net/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/VDI4VsOOSbqfv2sg-YOuPQ/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/50bd7612f0cdc8d43d3eacf0ac055894d573642118344137d9af35975bd100ae8a5ba37d370727fffd23927c3edd185d7faa0f1406f74ad85f69bbf534337474", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2100ba9bef4a83ca52cc740dd79319a285c96abeb8f673e211548425cd68831b3a2784a09e14cccf24a0cb621391fe7eb110f03f8e4a4c2a7a0537a990e81c47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ce5a054e6e1c4e573fee21e8c5b28d987b463f3174020088985317da9af41f696914cfa280fa6cb332d13aa2c5e3148d82e09588cb8dc7aa9a41fa31ddb80ed"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 05:26:32.580463) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 05:26:32.580878) ========= 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=aa52b8aba932b19cc50b5275000001de-1463398741.952602-800443997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 05:26:32.665865) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 05:26:32.666203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 05:26:32.666541) ========= ========= Total master_lag: 0.17 =========