builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1464904971.74 results: success (0) buildid: 20160602132435 builduid: af06dce269a04441a450a5ce56122df0 revision: 28e5f7d006ddb08850ee04a6b22178376c8797c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:51.739622) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:51.740096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:51.740373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:51.755202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:51.755605) ========= 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=0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 15:02:52-- 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% 113M=0s 2016-06-02 15:02:52 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108490 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:51.877990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:51.878304) ========= 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=0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020216 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:51.927584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 15:02:51.927938) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 28e5f7d006ddb08850ee04a6b22178376c8797c4 --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 28e5f7d006ddb08850ee04a6b22178376c8797c4 --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=0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 15:02:52,401 truncating revision to first 12 chars 2016-06-02 15:02:52,401 Setting DEBUG logging. 2016-06-02 15:02:52,401 attempt 1/10 2016-06-02 15:02:52,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/28e5f7d006dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 15:02:53,872 unpacking tar archive at: fx-team-28e5f7d006dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.815440 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 15:02:53.756859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:53.757181) ========= script_repo_revision: 28e5f7d006ddb08850ee04a6b22178376c8797c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:53.757591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:53.757871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 15:02:53.768095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-02 15:02:53.768579) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:02:54 INFO - MultiFileLogger online at 20160602 15:02:54 in /builds/slave/test 15:02:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:02:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:02:54 INFO - {'append_to_log': False, 15:02:54 INFO - 'base_work_dir': '/builds/slave/test', 15:02:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:02:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:02:54 INFO - 'branch': 'Fx-Team-Non-PGO', 15:02:54 INFO - 'buildbot_json_path': 'buildprops.json', 15:02:54 INFO - 'config_files': ('talos/linux_config.py',), 15:02:54 INFO - 'default_actions': ('clobber', 15:02:54 INFO - 'read-buildbot-config', 15:02:54 INFO - 'download-and-extract', 15:02:54 INFO - 'populate-webroot', 15:02:54 INFO - 'create-virtualenv', 15:02:54 INFO - 'install', 15:02:54 INFO - 'run-tests'), 15:02:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:02:54 INFO - 'download_minidump_stackwalk': True, 15:02:54 INFO - 'download_symbols': 'ondemand', 15:02:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:02:54 INFO - 'tooltool.py': '/tools/tooltool.py', 15:02:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:02:54 INFO - '/tools/misc-python/virtualenv.py')}, 15:02:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:02:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:02:54 INFO - 'installer_path': 'installer.exe', 15:02:54 INFO - 'log_level': 'info', 15:02:54 INFO - 'log_name': 'talos', 15:02:54 INFO - 'log_to_console': True, 15:02:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:02:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:02:54 INFO - 'opt_config_files': (), 15:02:54 INFO - 'pip_index': False, 15:02:54 INFO - 'sps_profile': False, 15:02:54 INFO - 'sps_profile_interval': 0, 15:02:54 INFO - 'suite': 'dromaeojs-e10s', 15:02:54 INFO - 'system_bits': '32', 15:02:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:02:54 INFO - 'title': 'talos-linux64-ix-017', 15:02:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:02:54 INFO - 'use_talos_json': True, 15:02:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:02:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:02:54 INFO - 'work_dir': 'build'} 15:02:54 INFO - ##### 15:02:54 INFO - ##### Running clobber step. 15:02:54 INFO - ##### 15:02:54 INFO - Running pre-action listener: _resource_record_pre_action 15:02:54 INFO - Running main action method: clobber 15:02:54 INFO - rmtree: /builds/slave/test/build 15:02:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:02:54 INFO - Running post-action listener: _resource_record_post_action 15:02:54 INFO - ##### 15:02:54 INFO - ##### Finished clobber step (success) 15:02:54 INFO - ##### 15:02:54 INFO - ##### 15:02:54 INFO - ##### Running read-buildbot-config step. 15:02:54 INFO - ##### 15:02:54 INFO - Running pre-action listener: _resource_record_pre_action 15:02:54 INFO - Running main action method: read_buildbot_config 15:02:54 INFO - Using buildbot properties: 15:02:54 INFO - { 15:02:54 INFO - "project": "", 15:02:54 INFO - "product": "firefox", 15:02:54 INFO - "script_repo_revision": "production", 15:02:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:02:54 INFO - "repository": "", 15:02:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:02:54 INFO - "buildid": "20160602132435", 15:02:54 INFO - "pgo_build": "False", 15:02:54 INFO - "basedir": "/builds/slave/test", 15:02:54 INFO - "buildnumber": 1334, 15:02:54 INFO - "slavename": "talos-linux64-ix-017", 15:02:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:02:54 INFO - "platform": "ubuntu64_hw", 15:02:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:02:54 INFO - "branch": "fx-team", 15:02:54 INFO - "repo_path": "integration/fx-team", 15:02:54 INFO - "revision": "28e5f7d006ddb08850ee04a6b22178376c8797c4", 15:02:54 INFO - "stage_platform": "linux64", 15:02:54 INFO - "builduid": "af06dce269a04441a450a5ce56122df0", 15:02:54 INFO - "slavebuilddir": "test" 15:02:54 INFO - } 15:02:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:02:54 INFO - Running post-action listener: _resource_record_post_action 15:02:54 INFO - ##### 15:02:54 INFO - ##### Finished read-buildbot-config step (success) 15:02:54 INFO - ##### 15:02:54 INFO - ##### 15:02:54 INFO - ##### Running download-and-extract step. 15:02:54 INFO - ##### 15:02:54 INFO - Running pre-action listener: _resource_record_pre_action 15:02:54 INFO - Running main action method: download_and_extract 15:02:54 INFO - mkdir: /builds/slave/test/build/tests 15:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:54 INFO - https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:02:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:02:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:02:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:02:55 INFO - Downloaded 1361 bytes. 15:02:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:02:55 INFO - Using the following test package requirements: 15:02:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:02:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:02:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:55 INFO - u'jsshell-linux-x86_64.zip'], 15:02:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:02:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:02:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:02:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:02:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:02:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:02:55 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')]} 15:02:55 INFO - https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:02:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:02:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:02:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:02:56 INFO - Downloaded 22866938 bytes. 15:02:56 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'] 15:02:56 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 15:02:57 INFO - Return code: 0 15:02:57 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 15:02:57 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')]} 15:02:57 INFO - https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:02:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:02:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:02:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:02:58 INFO - Downloaded 22866938 bytes. 15:02:58 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'] 15:02:58 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 15:03:00 INFO - Return code: 0 15:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:00 INFO - https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:03:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:03:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:03:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:03:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:03:01 INFO - Downloaded 10834055 bytes. 15:03:01 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'] 15:03:01 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 15:03:02 INFO - Return code: 0 15:03: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')]} 15:03:02 INFO - https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:03:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:03:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:03:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:03:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV_oakX4RmuBOFp4QcYugQ/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 15:03:03 INFO - Downloaded 55084756 bytes. 15:03:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:03:03 INFO - mkdir: /builds/slave/test/properties 15:03:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:03:03 INFO - Writing to file /builds/slave/test/properties/build_url 15:03:03 INFO - Contents: 15:03:03 INFO - build_url:https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:03:04 INFO - Running post-action listener: _resource_record_post_action 15:03:04 INFO - Running post-action listener: set_extra_try_arguments 15:03:04 INFO - ##### 15:03:04 INFO - ##### Finished download-and-extract step (success) 15:03:04 INFO - ##### 15:03:04 INFO - ##### 15:03:04 INFO - ##### Running populate-webroot step. 15:03:04 INFO - ##### 15:03:04 INFO - Running pre-action listener: _resource_record_pre_action 15:03:04 INFO - Running main action method: populate_webroot 15:03:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:03:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:03:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:03:04 INFO - '--tppagecycles', 15:03:04 INFO - '7'], 15:03:04 INFO - 'tests': ['tsvgm']}}, 15:03:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:03:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:03:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:03:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:03:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:03:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:03:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:04 INFO - 'talos_options': ['--disable-e10s'], 15:03:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:03:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:03:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:04 INFO - 'talos_options': ['--disable-e10s'], 15:03:04 INFO - 'tests': ['damp', 'tps']}, 15:03:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:04 INFO - 'tests': ['damp', 'tps']}, 15:03:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:03:04 INFO - 'tests': ['dromaeo_dom']}, 15:03:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:03:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:03:04 INFO - 'tests': ['a11yr', 15:03:04 INFO - 'ts_paint', 15:03:04 INFO - 'tpaint', 15:03:04 INFO - 'sessionrestore', 15:03:04 INFO - 'sessionrestore_no_auto_restore', 15:03:04 INFO - 'tabpaint']}, 15:03:04 INFO - 'other-e10s': {'tests': ['a11yr', 15:03:04 INFO - 'ts_paint', 15:03:04 INFO - 'tpaint', 15:03:04 INFO - 'sessionrestore', 15:03:04 INFO - 'sessionrestore_no_auto_restore', 15:03:04 INFO - 'tabpaint']}, 15:03:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:03:04 INFO - 'ts_paint', 15:03:04 INFO - 'tpaint', 15:03:04 INFO - 'sessionrestore', 15:03:04 INFO - 'sessionrestore_no_auto_restore', 15:03:04 INFO - 'tabpaint']}, 15:03:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:03:04 INFO - 'ts_paint', 15:03:04 INFO - 'tpaint', 15:03:04 INFO - 'sessionrestore', 15:03:04 INFO - 'sessionrestore_no_auto_restore', 15:03:04 INFO - 'tabpaint']}, 15:03:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:03:04 INFO - 'tests': ['a11yr', 15:03:04 INFO - 'ts_paint', 15:03:04 INFO - 'tpaint', 15:03:04 INFO - 'sessionrestore', 15:03:04 INFO - 'sessionrestore_no_auto_restore', 15:03:04 INFO - 'tabpaint']}, 15:03:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:03:04 INFO - 'tests': ['a11yr', 15:03:04 INFO - 'ts_paint', 15:03:04 INFO - 'tpaint', 15:03:04 INFO - 'sessionrestore', 15:03:04 INFO - 'sessionrestore_no_auto_restore', 15:03:04 INFO - 'tabpaint']}, 15:03:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:03:04 INFO - 'tests': ['tsvgx', 15:03:04 INFO - 'tsvgr_opacity', 15:03:04 INFO - 'tart', 15:03:04 INFO - 'tscrollx', 15:03:04 INFO - 'cart']}, 15:03:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:03:04 INFO - 'tsvgr_opacity', 15:03:04 INFO - 'tart', 15:03:04 INFO - 'tscrollx', 15:03:04 INFO - 'cart']}, 15:03:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:04 INFO - 'talos_options': ['--disable-e10s'], 15:03:04 INFO - 'tests': ['tp5o']}, 15:03:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:04 INFO - 'tests': ['tp5o']}, 15:03:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:04 INFO - 'talos_options': ['--disable-e10s', 15:03:04 INFO - '--xperf_path', 15:03:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:03:04 INFO - 'tests': ['tp5n']}, 15:03:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:04 INFO - 'talos_options': ['--xperf_path', 15:03:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:03:04 INFO - 'tests': ['tp5n']}}, 15:03:04 INFO - 'talos.zip': {'path': '', 15:03:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:03:04 INFO - Running post-action listener: _resource_record_post_action 15:03:04 INFO - ##### 15:03:04 INFO - ##### Finished populate-webroot step (success) 15:03:04 INFO - ##### 15:03:04 INFO - ##### 15:03:04 INFO - ##### Running create-virtualenv step. 15:03:04 INFO - ##### 15:03:04 INFO - Running pre-action listener: _resource_record_pre_action 15:03:04 INFO - Running main action method: create_virtualenv 15:03:04 INFO - Creating virtualenv /builds/slave/test/build/venv 15:03:04 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 15:03:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:03:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:03:04 INFO - Using real prefix '/usr' 15:03:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:03:04 INFO - Installing distribute.............................................................................................................................................................................................done. 15:03:06 INFO - Installing pip.................done. 15:03:06 INFO - Return code: 0 15:03:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:06 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 0x7f8ff68f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f9c0>, '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 0x1d408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d40d50>, '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': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', '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 15:03:06 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 15:03:06 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 15:03:06 INFO - Using env: {'DISPLAY': ':0', 15:03:06 INFO - 'HOME': '/home/cltbld', 15:03:06 INFO - 'LANG': 'en_US.UTF-8', 15:03:06 INFO - 'LANGUAGE': 'en_US:en', 15:03:06 INFO - 'LOGNAME': 'cltbld', 15:03:06 INFO - 'MAIL': '/var/mail/cltbld', 15:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:06 INFO - 'MOZ_NO_REMOTE': '1', 15:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:06 INFO - 'NO_EM_RESTART': '1', 15:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:06 INFO - 'PWD': '/builds/slave/test', 15:03:06 INFO - 'SHELL': '/bin/bash', 15:03:06 INFO - 'SHLVL': '1', 15:03:06 INFO - 'TERM': 'linux', 15:03:06 INFO - 'TMOUT': '86400', 15:03:06 INFO - 'USER': 'cltbld', 15:03:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', 15:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:06 INFO - '_': '/tools/buildbot/bin/python'} 15:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:07 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 15:03:07 INFO - Cleaning up... 15:03:07 INFO - Return code: 0 15:03:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:03:07 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')]} 15:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:07 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')]} 15:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:07 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 0x7f8ff68f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f9c0>, '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 0x1d408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d40d50>, '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': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', '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 15:03:07 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 15:03:07 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 15:03:07 INFO - Using env: {'DISPLAY': ':0', 15:03:07 INFO - 'HOME': '/home/cltbld', 15:03:07 INFO - 'LANG': 'en_US.UTF-8', 15:03:07 INFO - 'LANGUAGE': 'en_US:en', 15:03:07 INFO - 'LOGNAME': 'cltbld', 15:03:07 INFO - 'MAIL': '/var/mail/cltbld', 15:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:07 INFO - 'MOZ_NO_REMOTE': '1', 15:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:07 INFO - 'NO_EM_RESTART': '1', 15:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:07 INFO - 'PWD': '/builds/slave/test', 15:03:07 INFO - 'SHELL': '/bin/bash', 15:03:07 INFO - 'SHLVL': '1', 15:03:07 INFO - 'TERM': 'linux', 15:03:07 INFO - 'TMOUT': '86400', 15:03:07 INFO - 'USER': 'cltbld', 15:03:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', 15:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:07 INFO - '_': '/tools/buildbot/bin/python'} 15:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:07 INFO - Downloading/unpacking psutil>=3.1.1 15:03:07 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 15:03:07 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 15:03:07 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 15:03:07 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 15:03:07 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 15:03:07 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 15:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:03:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:03:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:03:09 INFO - Installing collected packages: psutil 15:03:09 INFO - Running setup.py install for psutil 15:03:09 INFO - building 'psutil._psutil_linux' extension 15:03:09 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 15:03:09 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 15:03:09 INFO - building 'psutil._psutil_posix' extension 15:03:09 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 15:03:09 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 15:03:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:03:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:03:09 INFO - Successfully installed psutil 15:03:09 INFO - Cleaning up... 15:03:09 INFO - Return code: 0 15:03:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:09 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 0x7f8ff68f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f9c0>, '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 0x1d408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d40d50>, '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': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', '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 15:03:09 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 15:03:09 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 15:03:09 INFO - Using env: {'DISPLAY': ':0', 15:03:09 INFO - 'HOME': '/home/cltbld', 15:03:09 INFO - 'LANG': 'en_US.UTF-8', 15:03:09 INFO - 'LANGUAGE': 'en_US:en', 15:03:09 INFO - 'LOGNAME': 'cltbld', 15:03:09 INFO - 'MAIL': '/var/mail/cltbld', 15:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:09 INFO - 'MOZ_NO_REMOTE': '1', 15:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:09 INFO - 'NO_EM_RESTART': '1', 15:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:09 INFO - 'PWD': '/builds/slave/test', 15:03:09 INFO - 'SHELL': '/bin/bash', 15:03:09 INFO - 'SHLVL': '1', 15:03:09 INFO - 'TERM': 'linux', 15:03:09 INFO - 'TMOUT': '86400', 15:03:09 INFO - 'USER': 'cltbld', 15:03:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', 15:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:09 INFO - '_': '/tools/buildbot/bin/python'} 15:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:03:12 INFO - Installing collected packages: mozsystemmonitor 15:03:12 INFO - Running setup.py install for mozsystemmonitor 15:03:12 INFO - Successfully installed mozsystemmonitor 15:03:12 INFO - Cleaning up... 15:03:12 INFO - Return code: 0 15:03:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:12 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 0x7f8ff68f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f9c0>, '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 0x1d408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d40d50>, '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': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', '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 15:03:12 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 15:03:12 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 15:03:12 INFO - Using env: {'DISPLAY': ':0', 15:03:12 INFO - 'HOME': '/home/cltbld', 15:03:12 INFO - 'LANG': 'en_US.UTF-8', 15:03:12 INFO - 'LANGUAGE': 'en_US:en', 15:03:12 INFO - 'LOGNAME': 'cltbld', 15:03:12 INFO - 'MAIL': '/var/mail/cltbld', 15:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:12 INFO - 'MOZ_NO_REMOTE': '1', 15:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:12 INFO - 'NO_EM_RESTART': '1', 15:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:12 INFO - 'PWD': '/builds/slave/test', 15:03:12 INFO - 'SHELL': '/bin/bash', 15:03:12 INFO - 'SHLVL': '1', 15:03:12 INFO - 'TERM': 'linux', 15:03:12 INFO - 'TMOUT': '86400', 15:03:12 INFO - 'USER': 'cltbld', 15:03:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', 15:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:12 INFO - '_': '/tools/buildbot/bin/python'} 15:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:12 INFO - Downloading/unpacking blobuploader==1.2.4 15:03:12 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 15:03:12 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 15:03:12 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 15:03:12 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 15:03:12 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 15:03:12 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 15:03:14 INFO - Downloading blobuploader-1.2.4.tar.gz 15:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:03:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:03:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 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 15:03:14 INFO - Downloading docopt-0.6.1.tar.gz 15:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:03:15 INFO - Installing collected packages: blobuploader, requests, docopt 15:03:15 INFO - Running setup.py install for blobuploader 15:03:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:03:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:03:15 INFO - Running setup.py install for requests 15:03:15 INFO - Running setup.py install for docopt 15:03:15 INFO - Successfully installed blobuploader requests docopt 15:03:15 INFO - Cleaning up... 15:03:15 INFO - Return code: 0 15:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:15 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 0x7f8ff68f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f9c0>, '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 0x1d408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d40d50>, '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': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', '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 15:03:15 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 15:03:15 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 15:03:15 INFO - Using env: {'DISPLAY': ':0', 15:03:15 INFO - 'HOME': '/home/cltbld', 15:03:15 INFO - 'LANG': 'en_US.UTF-8', 15:03:15 INFO - 'LANGUAGE': 'en_US:en', 15:03:15 INFO - 'LOGNAME': 'cltbld', 15:03:15 INFO - 'MAIL': '/var/mail/cltbld', 15:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:15 INFO - 'MOZ_NO_REMOTE': '1', 15:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:15 INFO - 'NO_EM_RESTART': '1', 15:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:15 INFO - 'PWD': '/builds/slave/test', 15:03:15 INFO - 'SHELL': '/bin/bash', 15:03:15 INFO - 'SHLVL': '1', 15:03:15 INFO - 'TERM': 'linux', 15:03:15 INFO - 'TMOUT': '86400', 15:03:15 INFO - 'USER': 'cltbld', 15:03:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', 15:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:15 INFO - '_': '/tools/buildbot/bin/python'} 15:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:15 INFO - Running setup.py (path:/tmp/pip-_paWoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:15 INFO - Running setup.py (path:/tmp/pip-iF5QwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:16 INFO - Running setup.py (path:/tmp/pip-VXfcg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:16 INFO - Running setup.py (path:/tmp/pip-zpByHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:16 INFO - Running setup.py (path:/tmp/pip-f5ZhNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:16 INFO - Running setup.py (path:/tmp/pip-0RKx1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:16 INFO - Running setup.py (path:/tmp/pip-P5tIZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:16 INFO - Running setup.py (path:/tmp/pip-P37WCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:16 INFO - Running setup.py (path:/tmp/pip-IfJCc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:16 INFO - Running setup.py (path:/tmp/pip-KgEncf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:16 INFO - Running setup.py (path:/tmp/pip-_qnqPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:16 INFO - Running setup.py (path:/tmp/pip-3uMKZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:16 INFO - Running setup.py (path:/tmp/pip-EeRst6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:16 INFO - Running setup.py (path:/tmp/pip-2Wmq6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:16 INFO - Running setup.py (path:/tmp/pip-zA5erT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:16 INFO - Running setup.py (path:/tmp/pip-1VNsuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:17 INFO - Running setup.py (path:/tmp/pip-Ms6Zel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:03:17 INFO - Running setup.py install for manifestparser 15:03:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:03:17 INFO - Running setup.py install for mozcrash 15:03:17 INFO - Running setup.py install for mozdebug 15:03:17 INFO - Running setup.py install for mozdevice 15:03:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:03:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:03:17 INFO - Running setup.py install for mozfile 15:03:17 INFO - Running setup.py install for mozhttpd 15:03:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:03:17 INFO - Running setup.py install for mozinfo 15:03:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:03:17 INFO - Running setup.py install for mozInstall 15:03:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:03:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:03:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:03:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:03:17 INFO - Running setup.py install for mozleak 15:03:17 INFO - Running setup.py install for mozlog 15:03:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:03:18 INFO - Running setup.py install for moznetwork 15:03:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:03:18 INFO - Running setup.py install for mozprocess 15:03:18 INFO - Running setup.py install for mozprofile 15:03:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:03:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:03:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:03:18 INFO - Running setup.py install for mozrunner 15:03:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:03:18 INFO - Running setup.py install for mozscreenshot 15:03:18 INFO - Running setup.py install for moztest 15:03:18 INFO - Running setup.py install for mozversion 15:03:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:03:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:03:18 INFO - Cleaning up... 15:03:18 INFO - Return code: 0 15:03:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:18 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 0x7f8ff68f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f9c0>, '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 0x1d408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d40d50>, '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': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', '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 15:03:18 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 15:03:18 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 15:03:18 INFO - Using env: {'DISPLAY': ':0', 15:03:18 INFO - 'HOME': '/home/cltbld', 15:03:18 INFO - 'LANG': 'en_US.UTF-8', 15:03:18 INFO - 'LANGUAGE': 'en_US:en', 15:03:18 INFO - 'LOGNAME': 'cltbld', 15:03:18 INFO - 'MAIL': '/var/mail/cltbld', 15:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:18 INFO - 'MOZ_NO_REMOTE': '1', 15:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:18 INFO - 'NO_EM_RESTART': '1', 15:03:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:18 INFO - 'PWD': '/builds/slave/test', 15:03:18 INFO - 'SHELL': '/bin/bash', 15:03:18 INFO - 'SHLVL': '1', 15:03:18 INFO - 'TERM': 'linux', 15:03:18 INFO - 'TMOUT': '86400', 15:03:18 INFO - 'USER': 'cltbld', 15:03:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', 15:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:18 INFO - '_': '/tools/buildbot/bin/python'} 15:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:19 INFO - Running setup.py (path:/tmp/pip-lpEIaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:19 INFO - Running setup.py (path:/tmp/pip-DSnZ4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:19 INFO - Running setup.py (path:/tmp/pip-L4m7WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:19 INFO - Running setup.py (path:/tmp/pip-w55uWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:19 INFO - Running setup.py (path:/tmp/pip-zIx97s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:19 INFO - Running setup.py (path:/tmp/pip-RQ4qfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:19 INFO - Running setup.py (path:/tmp/pip-QmKtwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:19 INFO - Running setup.py (path:/tmp/pip-aAAjCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:19 INFO - Running setup.py (path:/tmp/pip-16wwLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:19 INFO - Running setup.py (path:/tmp/pip-n5Cg7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:19 INFO - Running setup.py (path:/tmp/pip-0LlZUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:19 INFO - Running setup.py (path:/tmp/pip-9fZoj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:19 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)) 15:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:19 INFO - Running setup.py (path:/tmp/pip-DcEFIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:20 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)) 15:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:20 INFO - Running setup.py (path:/tmp/pip-Jd1wVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:20 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)) 15:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:20 INFO - Running setup.py (path:/tmp/pip-N1ww5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:20 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)) 15:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:20 INFO - Running setup.py (path:/tmp/pip-cUAZZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:20 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)) 15:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:20 INFO - Running setup.py (path:/tmp/pip-VuQnOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:20 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)) 15:03:20 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)) 15:03:20 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)) 15:03:20 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)) 15:03:20 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)) 15:03:20 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)) 15:03:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:03:20 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 15:03:20 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 15:03:20 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 15:03:20 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 15:03:20 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 15:03:20 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 15:03:22 INFO - Downloading blessings-1.6.tar.gz 15:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:03:22 INFO - Installing collected packages: blessings 15:03:22 INFO - Running setup.py install for blessings 15:03:22 INFO - Successfully installed blessings 15:03:22 INFO - Cleaning up... 15:03:22 INFO - Return code: 0 15:03:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:03:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:22 INFO - Reading from file tmpfile_stdout 15:03:22 INFO - Current package versions: 15:03:22 INFO - argparse == 1.2.1 15:03:22 INFO - blessings == 1.6 15:03:22 INFO - blobuploader == 1.2.4 15:03:22 INFO - docopt == 0.6.1 15:03:22 INFO - manifestparser == 1.1 15:03:22 INFO - mozInstall == 1.12 15:03:22 INFO - mozcrash == 0.17 15:03:22 INFO - mozdebug == 0.1 15:03:22 INFO - mozdevice == 0.48 15:03:22 INFO - mozfile == 1.2 15:03:22 INFO - mozhttpd == 0.7 15:03:22 INFO - mozinfo == 0.9 15:03:22 INFO - mozleak == 0.1 15:03:22 INFO - mozlog == 3.2 15:03:22 INFO - moznetwork == 0.27 15:03:22 INFO - mozprocess == 0.22 15:03:22 INFO - mozprofile == 0.28 15:03:22 INFO - mozrunner == 6.11 15:03:22 INFO - mozscreenshot == 0.1 15:03:22 INFO - mozsystemmonitor == 0.3 15:03:22 INFO - moztest == 0.7 15:03:22 INFO - mozversion == 1.4 15:03:22 INFO - psutil == 3.1.1 15:03:22 INFO - requests == 1.2.3 15:03:22 INFO - wsgiref == 0.1.2 15:03:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:22 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 0x7f8ff68f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f9c0>, '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 0x1d408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d40d50>, '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': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', '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 15:03:22 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 15:03:22 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 15:03:22 INFO - Using env: {'DISPLAY': ':0', 15:03:22 INFO - 'HOME': '/home/cltbld', 15:03:22 INFO - 'LANG': 'en_US.UTF-8', 15:03:22 INFO - 'LANGUAGE': 'en_US:en', 15:03:22 INFO - 'LOGNAME': 'cltbld', 15:03:22 INFO - 'MAIL': '/var/mail/cltbld', 15:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:22 INFO - 'MOZ_NO_REMOTE': '1', 15:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:22 INFO - 'NO_EM_RESTART': '1', 15:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:22 INFO - 'PWD': '/builds/slave/test', 15:03:22 INFO - 'SHELL': '/bin/bash', 15:03:22 INFO - 'SHLVL': '1', 15:03:22 INFO - 'TERM': 'linux', 15:03:22 INFO - 'TMOUT': '86400', 15:03:22 INFO - 'USER': 'cltbld', 15:03:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', 15:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:22 INFO - '_': '/tools/buildbot/bin/python'} 15:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:22 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)) 15:03:22 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)) 15:03:22 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)) 15:03:22 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)) 15:03:22 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)) 15:03:22 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)) 15:03:22 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)) 15:03:22 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)) 15:03:22 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)) 15:03:22 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)) 15:03:22 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)) 15:03:22 INFO - Cleaning up... 15:03:22 INFO - Return code: 0 15:03:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:22 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 0x7f8ff68f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f9c0>, '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 0x1d408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d40d50>, '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': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', '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 15:03:22 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 15:03:22 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 15:03:22 INFO - Using env: {'DISPLAY': ':0', 15:03:22 INFO - 'HOME': '/home/cltbld', 15:03:22 INFO - 'LANG': 'en_US.UTF-8', 15:03:22 INFO - 'LANGUAGE': 'en_US:en', 15:03:22 INFO - 'LOGNAME': 'cltbld', 15:03:22 INFO - 'MAIL': '/var/mail/cltbld', 15:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:22 INFO - 'MOZ_NO_REMOTE': '1', 15:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:22 INFO - 'NO_EM_RESTART': '1', 15:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:22 INFO - 'PWD': '/builds/slave/test', 15:03:22 INFO - 'SHELL': '/bin/bash', 15:03:22 INFO - 'SHLVL': '1', 15:03:22 INFO - 'TERM': 'linux', 15:03:22 INFO - 'TMOUT': '86400', 15:03:22 INFO - 'USER': 'cltbld', 15:03:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', 15:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:22 INFO - '_': '/tools/buildbot/bin/python'} 15:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:23 INFO - Downloading/unpacking jsonschema 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:03:24 INFO - Downloading/unpacking functools32 (from jsonschema) 15:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:25 INFO - Downloading functools32-3.2.3-2.tar.gz 15:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:03:25 INFO - warning: no files found matching '*.txt' 15:03:25 INFO - no previously-included directories found matching 'build' 15:03:25 INFO - no previously-included directories found matching 'dist' 15:03:25 INFO - no previously-included directories found matching '.git*' 15:03:25 INFO - Installing collected packages: jsonschema, functools32 15:03:25 INFO - Running setup.py install for functools32 15:03:25 INFO - warning: no files found matching '*.txt' 15:03:25 INFO - no previously-included directories found matching 'build' 15:03:25 INFO - no previously-included directories found matching 'dist' 15:03:25 INFO - no previously-included directories found matching '.git*' 15:03:25 INFO - Successfully installed jsonschema functools32 15:03:25 INFO - Cleaning up... 15:03:25 INFO - Return code: 0 15:03:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ff68f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f9c0>, '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 0x1d408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d40d50>, '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': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', '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 15:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:03:25 INFO - Using env: {'DISPLAY': ':0', 15:03:25 INFO - 'HOME': '/home/cltbld', 15:03:25 INFO - 'LANG': 'en_US.UTF-8', 15:03:25 INFO - 'LANGUAGE': 'en_US:en', 15:03:25 INFO - 'LOGNAME': 'cltbld', 15:03:25 INFO - 'MAIL': '/var/mail/cltbld', 15:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:25 INFO - 'MOZ_NO_REMOTE': '1', 15:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:25 INFO - 'NO_EM_RESTART': '1', 15:03:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:25 INFO - 'PWD': '/builds/slave/test', 15:03:25 INFO - 'SHELL': '/bin/bash', 15:03:25 INFO - 'SHLVL': '1', 15:03:25 INFO - 'TERM': 'linux', 15:03:25 INFO - 'TMOUT': '86400', 15:03:25 INFO - 'USER': 'cltbld', 15:03:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', 15:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:25 INFO - '_': '/tools/buildbot/bin/python'} 15:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:25 INFO - Downloading/unpacking flake8 15:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:03:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:03:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 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 15:03:27 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 15:03:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:03:28 INFO - no previously-included directories found matching 'docs/_build' 15:03:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:03:28 INFO - Running setup.py install for pep8 15:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:03:28 INFO - no previously-included directories found matching 'docs/_build' 15:03:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:03:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:03:28 INFO - Cleaning up... 15:03:28 INFO - Return code: 0 15:03:28 INFO - Running post-action listener: _resource_record_post_action 15:03:28 INFO - Running post-action listener: _start_resource_monitoring 15:03:28 INFO - Starting resource monitoring. 15:03:28 INFO - ##### 15:03:28 INFO - ##### Finished create-virtualenv step (success) 15:03:28 INFO - ##### 15:03:28 INFO - ##### 15:03:28 INFO - ##### Running install step. 15:03:28 INFO - ##### 15:03:28 INFO - Running pre-action listener: _resource_record_pre_action 15:03:28 INFO - Running main action method: install 15:03:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:28 INFO - Reading from file tmpfile_stdout 15:03:28 INFO - Detecting whether we're running mozinstall >=1.0... 15:03:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:03:28 INFO - Reading from file tmpfile_stdout 15:03:28 INFO - Output received: 15:03:28 INFO - Usage: mozinstall [options] installer 15:03:28 INFO - Options: 15:03:28 INFO - -h, --help show this help message and exit 15:03:28 INFO - -d DEST, --destination=DEST 15:03:28 INFO - Directory to install application into. [default: 15:03:28 INFO - "/builds/slave/test"] 15:03:28 INFO - --app=APP Application being installed. [default: firefox] 15:03:28 INFO - mkdir: /builds/slave/test/build/application 15:03:28 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'] 15:03:28 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 15:03:44 INFO - Reading from file tmpfile_stdout 15:03:44 INFO - Output received: 15:03:44 INFO - /builds/slave/test/build/application/firefox/firefox 15:03:44 INFO - Running post-action listener: _resource_record_post_action 15:03:44 INFO - ##### 15:03:44 INFO - ##### Finished install step (success) 15:03:44 INFO - ##### 15:03:44 INFO - ##### 15:03:44 INFO - ##### Running run-tests step. 15:03:44 INFO - ##### 15:03:44 INFO - Running pre-action listener: _resource_record_pre_action 15:03:44 INFO - Running main action method: run_tests 15:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:03:44 INFO - Python 2.7.3 15:03:44 INFO - Return code: 0 15:03:44 INFO - grabbing minidump binary from tooltool 15:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:44 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 0x1d3f9c0>, '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 0x1d408c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d40d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:03:44 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 15:03:44 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 15:03:44 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 15:03:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:03:44 INFO - Return code: 0 15:03:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:03:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:03:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:03:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:03:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:03:45 INFO - Return code: 0 15:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 15:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 15:03:45 INFO - Using env: {'DISPLAY': ':0', 15:03:45 INFO - 'HOME': '/home/cltbld', 15:03:45 INFO - 'LANG': 'en_US.UTF-8', 15:03:45 INFO - 'LANGUAGE': 'en_US:en', 15:03:45 INFO - 'LOGNAME': 'cltbld', 15:03:45 INFO - 'MAIL': '/var/mail/cltbld', 15:03:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:03:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:45 INFO - 'MOZ_NO_REMOTE': '1', 15:03:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:45 INFO - 'NO_EM_RESTART': '1', 15:03:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:45 INFO - 'PWD': '/builds/slave/test', 15:03:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:03:45 INFO - 'SHELL': '/bin/bash', 15:03:45 INFO - 'SHLVL': '1', 15:03:45 INFO - 'TERM': 'linux', 15:03:45 INFO - 'TMOUT': '86400', 15:03:45 INFO - 'USER': 'cltbld', 15:03:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936', 15:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:45 INFO - '_': '/tools/buildbot/bin/python'} 15:03:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 15:03:45 INFO - mozversion application_buildid: 20160602132435 15:03:45 INFO - mozversion application_changeset: 28e5f7d006ddb08850ee04a6b22178376c8797c4 15:03:45 INFO - mozversion application_display_name: Nightly 15:03:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:03:45 INFO - mozversion application_name: Firefox 15:03:45 INFO - mozversion application_remotingname: firefox 15:03:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:03:45 INFO - mozversion application_vendor: Mozilla 15:03:45 INFO - mozversion application_version: 49.0a1 15:03:45 INFO - mozversion platform_buildid: 20160602132435 15:03:45 INFO - mozversion platform_changeset: 28e5f7d006ddb08850ee04a6b22178376c8797c4 15:03:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:03:45 INFO - mozversion platform_version: 49.0a1 15:03:45 INFO - using testdate: 1464905025 15:03:45 INFO - actual date: 1464905025 15:03:45 INFO - starting webserver on 'localhost:48585' 15:03:45 INFO - SUITE-START | Running 2 tests 15:03:45 INFO - TEST-START | dromaeo_css 15:03:45 INFO - operating with platform_type : linux_ 15:03:45 INFO - Initialising browser for dromaeo_css test... 15:03:45 INFO - TEST-INFO | started process 5329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzRv4QL/profile http://localhost:48585/getInfo.html) 15:03:50 INFO - PROCESS | 5329 | __metrics Screen width/height:1600/1200 15:03:50 INFO - PROCESS | 5329 | colorDepth:24 15:03:50 INFO - PROCESS | 5329 | Browser inner width/height: 1024/697 15:03:50 INFO - PROCESS | 5329 | __metrics 15:03:51 ERROR - PROCESS | 5329 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 15:03:51 INFO - TEST-INFO | 5329: exit 0 15:03:51 INFO - Browser initialized. 15:03:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:03:51 INFO - TEST-INFO | started process 5448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzRv4QL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:04:03 INFO - PROCESS | 5448 | RSS: Main: 168341504 15:04:03 INFO - PROCESS | 5448 | 15:04:53 INFO - PROCESS | 5448 | 1464905093428 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] 15:07:04 INFO - PROCESS | 5448 | Cycle 1(1): loaded http://localhost:48585/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48585/tests/dromaeo/cssquery-ext.html) 15:07:06 INFO - PROCESS | 5448 | RSS: Main: 171352064 15:07:06 INFO - PROCESS | 5448 | 15:10:08 INFO - PROCESS | 5448 | Cycle 1(1): loaded http://localhost:48585/tests/dromaeo/cssquery-ext.html (next: http://localhost:48585/tests/dromaeo/cssquery-jquery.html) 15:10:08 INFO - PROCESS | 5448 | RSS: Main: 170106880 15:10:08 INFO - PROCESS | 5448 | 15:13:10 INFO - PROCESS | 5448 | Cycle 1(1): loaded http://localhost:48585/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48585/tests/dromaeo/cssquery-mootools.html) 15:13:11 INFO - PROCESS | 5448 | RSS: Main: 171634688 15:13:11 INFO - PROCESS | 5448 | 15:16:13 INFO - PROCESS | 5448 | Cycle 1(1): loaded http://localhost:48585/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48585/tests/dromaeo/cssquery-prototype.html) 15:16:14 INFO - PROCESS | 5448 | RSS: Main: 169066496 15:16:14 INFO - PROCESS | 5448 | 15:19:16 INFO - PROCESS | 5448 | Cycle 1(1): loaded http://localhost:48585/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48585/tests/dromaeo/cssquery-yui.html) 15:19:17 INFO - PROCESS | 5448 | RSS: Main: 171053056 15:19:17 INFO - PROCESS | 5448 | 15:22:19 INFO - PROCESS | 5448 | Cycle 1(1): loaded http://localhost:48585/tests/dromaeo/cssquery-yui.html (next: http://localhost:48585/tests/dromaeo/cssquery-dojo.html) 15:22:20 INFO - PROCESS | 5448 | RSS: Main: 172244992 15:22:20 INFO - PROCESS | 5448 | 15:22:20 INFO - PROCESS | 5448 | __start_tp_report 15:22:20 INFO - PROCESS | 5448 | _x_x_mozilla_page_load 15:22:20 INFO - PROCESS | 5448 | _x_x_mozilla_page_load_details 15:22:20 INFO - PROCESS | 5448 | |i|pagename|runs| 15:22:20 INFO - PROCESS | 5448 | |0;dojo.html;2652.681678198616;2702.283894767886;2726.236653736953;2735.726427357263;2747.395572973945;4719.126961512118;4742.122707299152;4777.8088876444945;4832.639732382876;4878.29264756611;4738.052389522092;4774.49867763885;4848.587870031043;4852.247901575252;4897.142999974999;4378.540253273401;4403.273459879116;4469.9106017879785;4482.843100491484;4515.074409746011;4171.770552619605;4458.4426946631675;4523.389342438762;4529.705569138012;4565.292379681138;4362.345648152771;4393.472783265996;4415.359772832953;4431.047324825178;4527.615152712024;4332.67504937131;4355.128974205171;4445.199864024475;4457.28683410656;4476.776161191928;4433.312836510346;4434.512203657595;4439.667024973108;4480.305552639346;4480.529544397824;4575.794089265991;4706.670533062687;4707;4708.788104535304;4741.478437371887;5129.563987061104;5146.433892271847;5149.176131818891;5158.716270605115;5211.973940130313;5152.974235128838;5185.144451165553;5186.948130518722;5188.325517682715;5198;4869.269609558523;4872.196087645499;4874.073925954058;4892.192788189945;4935.407751069859;5337.146056630921;5343.251944727741;5358.866028349323;5362.436944120811;5365.248865158881;4987.127252730757;5030.949690503048;5082.517160869711;5082.822101226439;5113.411957624847;5019.723915184627;5102.744862756847;5108.106081435734;5116.437191908887;5130.307408499804;5033.446320904697;5092.592592592584;5097.0315640028275;5112.642115051911;5122.129238029544;4958.181899986534;5043.823466178666;5100.515451032146;5105.540501354896;5109.463506331782;4398.252297109499;4398.956010439919;4422.226110430662;4432.3794668746405;4459.687821852439;3813.389857622767;3846.4614953906475;3852.8266228019247;3854.2869569129803;3876.2635099331037;4388.1223755249075;4498.482674492409;4530.682852200314;4533.138703646297;4562.475315338712;5241.213817927342;5245.7114858683135;5249.186376111708;5266.052110620125;5277.287566178594;4545.36364908913;4557;4563.573610897906;4573.748443835554;4581.129585378767;4571.748553829571;4616.192166370939;4619.5611416915335;4643.953560464352;4745.383100197021;4741.857744267678;4793.472718001017;4823.493533178966;4827.08285425768;4867.440244371943;5155.948440515547;5206.713630750345;5208.244804503402;5216.191490319006;5257.763400647056;4693.084848454519;4805.327254184347;4864.100141473838;4884.8290309838985;4903.16646170159;5163.922541161811;5165.741712914414;5166.819161329486;5172.663776854492;5226.660267082628;5033.899322013466;5248.1340578804065;5257.2902658140665;5259.368875734936;5261.473852614861;4958.181899986606;5021.322121513549;5028.245763135413;5051.419086805065;5077.416097148727;5069.822556210515;5100.48995100487;5114.977004599169;5115.25828754821;5115.9232611510115;5026.095302845523;5053.2420136979745;5053.418856831511;5055.646104772778;5084.8220312288895;4954.3311652926395;4992.525710057539;5051.116054690341;5057.089723849743;5057.494250574913;4918.852434426973;4949.901001980013;4951.257311403318;4953.455119936876;4997.275395067768 15:22:20 INFO - PROCESS | 5448 | |1;ext.html;561.539537579185;601.0173366545698;606.4723690389359;615.4030590327383;619.4363129552108;35008.12479688006;39474.210515789666;39625.20749585007;39684.404733928975;39710.8014459928;41096;41336.79331603338;41688.791556042175;41702.7914860426;41759.37360939589;7634.809129771758;7782.143964163937;7793.2596403341595;7809.960950195241;7839.137694853562;7664.118626357985;7774.727884524043;7779.222077792204;7800.570968596725;7806.297433231008;7650.885236721426;7722.420818438612;7786.454948153631;7796.298333150015;7808.60956952153;7733.9226607734045;7776.222377762235;7782.64978075988;7793.76618701437;7802.68789248435;7706.576138312391;7712.267334603203;7715.729949451742;7791.259830316168;7808.180141085161;37705;37969.24061518782;38163.23673526514;38209.426858597144;38254.234915301815;2972.7175918287726;3007.323352245727;3098.922526936822;3386.881459148918;3701.8704345347783;27274.863625681945;29880;30110.397792044256;30132.84933575318;30136.698633013828;3535.045537704805;3561.3055454186183;3576.91057723559;3592.6407359264126;3609.260101679176;410414;416373;417082;417835;417944;56464.43535564674;57405.42594574084;57443.42556574464;58065.806380648624;58119;36124.27751445009;62487.37512624815;62584.37415625877;62999.68500157561;63031.36968630255;15442.22788860575;15628.843711562738;15683.1374274416;15706.057636541844;15774.842251577338;11705.297682139098;11839.822402663967;11870.703232419086;11893.643190704293;11907.761844763056;18993.525161871064;19040.333588324618;19080;19093.2362705493;19102.80897191038;6920.826979325557;7151.7854464366155;7234.131904171533;7234.168070671835;7359.30735930739;848.7114381110453;849.2781136034322;939.4926739560698;994.7015895231401;1003.0320740485466;27905.441891162063;28796.568051479244;29159.271018224714;29322.26694332616;29753.702462975525;1020.6682828080903;1022.6829682798357;1025.36939782035;1039.8440233964966;1086.4947799273375;15011.549653510412;15234;15285.694286114216;15474.303656335493;15616.687666246611;381904;666321;680140;682006;683210;51791.22313165305;51802.22296665553;51961.48038519642;52147.95704085897;52151.47848521466;1217.598192596441;1240.2124650846597;1254.021862946903;1255.554278231233;1256.9183003104952;27771.44457110887;29450;29612;30072.5489117659;30119.698803012565;45453.772731137455;45712.08575828531;45957.31064034109;45965.77017114893;46049.30926036045;361785;362167;367096;369602;370404;25695;25966.92264618864;26413.471730564896;26758.063467778535;26759.929602815668;43398.34902476529;43584;43705.56294437015;43767;44435.777821110685;36883;37694.434583480725;37724.81137594295;38105.80947095247;38199;36343.273134536634;37176.62823371732;37447.43828842624;37497.437538437494;37702.62297376991;36272.27455450929;36442.27115457729;36808;37215.813920930224;37242.25515489729;32732.50901236531;33341.499877501374;33673;33887.83056084704;33967.4904876432;25695.614565781154;25824.48351032931;26089.217323480327;26095.478090438464;26272 15:22:20 INFO - PROCESS | 5448 | |2;jquery.html;356.88579654510556;359.30115924526797;363.6527116603642;374.3374227617116;383.81001404304874;15576.922115389421;16348.591285217875;17315.307387704477;17348.045857477835;17506.037167955757;16262.75605865913;16331.265093070811;17086.658266834656;17237;17252.137393130324;5058.69647821131;5198.116320225552;5237.633365664405;5240.528352448279;5250.606204534656;3691.427828686558;5107.540321371076;5768.567357448187;6058.394160583928;6060.2424696912885;6038.818835434944;6075.210222671047;6077.24034495688;6081.665508397036;6083.78706745264;4851.539103785135;5155.046316431453;5161.30322406476;5218.086834803894;5241.685498870042;4975.4527002029745;5030.471800460936;5049.192129259301;5121.974390128063;5137.6403651744395;11701.3564253966;11765.823512647317;11888.048956083492;13192;19966.30117945865;1714.1686282153146;1791.3730194431976;1808.0688445450603;1815.155952482102;1908.9618207635908;8728.650853965833;9143.405678630868;9149.588268527865;9179.541022948826;9206.447613143166;1730.221400369826;1766.4788887278285;1793.5426466251154;1810.3663717698832;1845.2895635180419;68018;69384.65307673429;70083;70809;71313;9448.90551094494;9745.31782775199;9750;9792.902070979198;9926.2059035277;13246.73506529864;13272.668183295495;13288.534901278408;13323.533676321476;13371.06402551812;6937.7571784987285;7111.751088711871;7141.750038748619;7153.89269160963;7195.676194571152;6667.86664266712;6973.919042548413;6977.755778547727;6997.825054373681;7315.524490908074;4013.1171142348635;4031.8387264509092;4078;4147.8963025924595;4161.271777438936;1588.896721713108;1613.5159452164303;1726.3008481564987;1750.2998800479656;1758.0485660916372;848.3976376772438;881.9073997230198;901.2699713232303;936.6159874451442;977.6578197630772;15663.68672626541;15787.526374208792;17607.207675654627;17844.643107138043;18010.189541470667;838.8490071787015;846.0439703135418;880.3881302494833;923.8706581078654;928.8653145293895;9201.49391783445;9306.441613503212;9542.280450071696;9568;9647.951760241154;367440;371580;372400;372453;377690;48021.279680804815;48086;72875.63562182155;76409.61795190988;77357.22642773612;951.4481600671594;965.5461932891529;979.6179489999049;1000.1099021870396;1001.8597396364515;14953.177575233467;14980.1011939284;15062.623434414227;15166.090034597959;15390.461333853262;24239.394015149763;25286.24141275765;35074.64925350714;35522.28955420929;35745.82127089348;48200;49083.26375104448;49277.26084108813;49346.25980610222;49381.506184937694;4890;6782.69477873487;7376.336129748348;7531.3974882008215;7729.4202934779;7735.497192682457;10368.703912010998;11139.108871290115;11269.323840569592;11403.315801051964;9520.761980950532;9624.855627165458;9674.129328360481;9831.803363932824;9899.307048506535;9599.664011759554;9644.421334719938;9843.212542996685;9848.212143028684;10062.547185376821;4974.477679843564;8571.528565928933;9312.394694344846;9316.254699624149;9845.606175753177;7261.709531618676;7302.379297759538;7334.779956601311;7394.7781566553085;7497.370087298293;8814.779630509289;9478.478683672189;9549.997250288898;9733;9859.852102218616 15:22:20 INFO - PROCESS | 5448 | |3;mootools.html;1401.0262867307222;1422.11118051218;1513.1904431129349;1702.8382303681146;1717.5019244419118;5899.823005309837;6756.628385438799;6769.5599786014;7159.427245820335;7163.212046674862;6866.176058872942;7078.186008609012;7079.327463890922;7091.219965803757;7121.216666166718;2050.897455127245;2093.42430831521;2096.1091536097174;2099.737532808399;2102.3482720356737;2006.3178519303433;2014.6272939506239;2019.9899000504977;2046.4270004398793;2052.384284714587;2077.1795140919326;2080.0431801371387;2090.216168936649;2092.7279453671076;2098.7481502219757;1958.5789055353025;1965.5872266823985;1971.9014049297477;1972.6350625134396;1974.3188599933;1950.1516840174427;1953.5116220944765;1967.5868067705799;1985.8014198580026;1993.2624928776445;7040.859182816315;7062.894056589155;7079.150501939749;7104.822379440556;7121.89317160243;4211.915761684749;4323.178596066738;4334.089841133366;4373.825046998148;4400.185965596343;2702.9594556081674;2796.3708165662765;2841.0482488366424;2863.2698661841305;2878.9280267993468;850.408965768791;866.3242670716851;887.7514295997131;901.4951627088851;904.1500989070319;9146.314026448043;9147.313951453601;9193.448393096369;9253.074692530694;9259.259259259243;3810.2189051244427;3855.556610989716;3871.2064026874423;3904.316744569689;3922;8151.633176507072;8157.265846073882;8173.509589424653;8190.836183276301;8200.179982001751;4156.231097247019;4157.91684166315;4163.687723420695;4168.916621667549;4177.185448837447;3374.814385208837;3692.280005398975;3820.56063552695;3917.4319723639915;3964.2467931093;3401.2687272236094;3406.267652454734;3478.756487045933;3493.5458390409085;3619.3485172668647;1062.824633935392;1077.978440431187;1081.1566977757361;1082.09644946469;1101.2566517600587;844.3582877013391;861.6467248428114;878.9956050219708;879.692107762278;890.7238755985666;5018.974905125524;5050.823221187241;5107.719075450812;5213.2701421800975;5222.556082732935;804.284187073505;866.7659731872485;877.0965905117739;903.2367649336301;909.2589539525397;3526.506289119474;3557.7509574330065;3618.457231415256;3668.926621467556;3687.59436461989;7985.600719963979;8193.180681931759;8311.293540049042;8332.125126861714;8362.331013518904;8246.05170405399;8266.834663306821;8277.710280140167;8282.751517454486;8303.95848020756;6600.108985287021;6739.258681545026;6748.089007983859;6782.660866956534;6787.5588086774205;4898.289747986593;5041.294218809297;5125.846224613268;5163.044836705221;5231.6860988339295;7720.53676779395;7830.451868369388;7914.089879663912;7918.485298455582;7998.040235171817;7515.173330933702;7821.296083352526;7822.843543129219;7997.080335761462;8053.154418785943;5580.944190558205;6103.267607887082;6264.467520260829;6468.417842394207;6662.900056499059;6493.123428337114;6624.9337506624315;6632.436242919406;6674.799756007327;6687.364700353459;6106.816795496142;6169.876602468015;6229.595076320024;6328.272248691459;6344.492440604833;6130.601510901777;6132.63204207749;6212.0371342441995;6275;6293.937060629335;5874;5985.132155837292;5985.341612422543;6010;6029.246344206974;4251.95748042528;4317.417148684887;4345.956540434555;4367.71152510004;4396.560343965578;4299.849505267301;4381.079973205535;4400.471943366816;4443.977780111079;4451.198784218872 15:22:20 INFO - PROCESS | 5448 | |4;prototype.html;288.1628868138058;290.6178375436301;297.6918888949936;301.10571602341054;301.2919638848707;4792.185328494155;4922.70463772173;5055.620828437868;5065.645404821664;5071.568916642085;4977.527134922186;4984.725840078794;4996.825111121111;5010.874728131798;5020.849374518762;3914;3916.1971795781938;3918.8628398006076;3924.274009308273;3924.803759812005;3695.3902606069964;3916.2559113768293;3923.5487918889407;3929.0766669832565;3940.2316548272956;3805.676517496016;3837.194189220267;3853.344931361661;3854.9807250963704;3858.2283543291455;3869.496965394509;3870.6516413522777;3881.9611803882162;3903.4535165077054;3905.7461265017682;3428.777129486575;3431.1936694876686;3437.1750779812915;3444.7588668793196;3445.2248244145117;4579.748113853737;4759.357486739281;4759.4764575896625;4817.397825271841;4839.806407743686;4367.934480982788;4385.693001489897;4388.188185185719;4410.62509686677;4415.51429342772;5205.063088644042;5223.738813059332;5233.1888557273305;5259;5278.392984806719;3662.359087159736;3732.9440058399146;3744.307303148926;3763.209725957552;3773.113318370181;5523.806666766684;5563.693996830173;5577.637453565505;5591.294655130184;5592.273004509429;3858.6720128789366;3889.3388124018984;3891.3968334908136;3905.1213476967455;3908.335582950905;3957.8614748483665;3959.742616729903;3970.344893092665;3973.8609148679657;3999.680025597945;4287.356896465555;4423.203823311835;4423.5576442355505;4424.778761061998;4479.260921947842;5220.556252718561;5226.608004399685;5239.711815850165;5271.710055946883;5289.259503669489;1267.0370518406078;1334.1728128560355;1351.2635613590421;1356.85752995936;1362.2167253829089;865.5801936061006;869.1004810021598;872.7432497204006;879.2833840420037;888.3870129610548;4130.657536300714;4137.648299894482;4141.875743727693;4174.83300667976;4196.328587425997;4718.598919091847;4748.264019077049;4757.405324334458;4775.403074615673;4776.519279023514;4198.782353117623;4217;4221.97889010553;4239.745615263094;4246.8301267949555;2506.749325067479;2561.1932241343916;2613.7908967282574;2618.751218634227;2646.325187077283;4492.213862574036;4566.383538222364;4581.816727330936;4607.815687372535;4608.677392582487;4788.832390866303;4895.632827537949;4928.408590969107;4945.4312754033745;4958.231474121517;4566.543345665474;4702.318163866289;5050.419201791841;5072.391313042459;5089.923651145235;5440.700761458158;5453.972730136324;5481.150421684645;5492.697901615449;5493;5268.894622107459;5351.491608297206;5366;5387.973060134675;5418.918716219181;5092.955944031539;5099.643024988363;5114.360704911886;5116.590672746246;5128.384593848762;3702.315071711742;3721.292954338667;3735.5704094029534;3749.2501499699624;3767.3218820611455;5004.249362595494;5382.892342153214;5443.8153680097585;5463.399026107046;5507.889842203213;5295.894082118259;5334.493223143795;5344.305240318734;5379.789547351815;5399.325084364455;5326.7336633167415;5335.706536140549;5361.329833770778;5369.167778994262;5371.838844834661;5076.974615126901;5191.922121168261;5244.554212891947;5253.50091741284;5295.655782374288;5334.532553840035;5348.839534813962;5357.330333708286;5402.51377376038;5445.584148121596;5207.739613019258;5214.582833373245;5232.136697445031;5313.415524292247;5354.866128346823 15:22:20 INFO - PROCESS | 5448 | |5;yui.html;626.7868924565647;687.6596084937953;697.9127609048868;701.1340993872569;759.3697231298023;12162.81755773663;13202.669933251673;13236.338183090844;14808.11151330921;15393.307301171446;15080.472183473581;15229.847701522982;15240.618984525392;15254.694906101871;15309.69380612387;632.8512799492139;785.9331956783681;813.5769399912057;824.9876251856197;827.0943317067802;802.2458888644655;807.0355924670022;808.7695006923028;810.3193317613204;810.5460941872541;861.7113267055544;862.5083702289666;865.3899001204136;868.8696695495663;870.5212133326677;862.7239283429274;862.9352798540103;863.2489733931457;863.8185980943947;864.1142828600703;632.9303776584572;633.6989929783363;633.7053270229366;634.2199095112991;634.3592971099177;14154.50459233932;14426;14473.78289325661;14477.638059048502;14482.782758258634;12217;12663.430145643468;13153.145045572008;13298.468061277537;13329.466821327233;10994.890051099546;11077.335359878432;11170.218084734071;11237.83143252852;11340.206185567014;3367.4107031269673;3384.76306658534;3414.5219669246326;3416.829158542063;3481.8433170507387;62824.68587657032;62999.685001575155;63900.680496597684;63989.3601063988;64466.35533644697;10316;10333.896661033445;10375.792484150426;10464.110550603284;10515.94742026285;19383.612327753366;19392.70910936337;19405.223791048484;19451.80548194528;19805.702914456295;6864.862702745917;6887.586744795329;6979.89530157048;6993.685284162225;7063.89404158938;3863.2273545291055;3867.439221312894;3936.5079365079364;3941.1132495188353;3957.5250969883223;3042.3763128558594;3197.0728488738005;3200.4719221328687;3204.759643026782;3210.646828848825;495.40798745498785;497.4950425318305;500.684568721703;502.21904937822035;508.9618278629118;475.2396166134227;493.7235148316954;556.7084364274924;592.404633343487;598;7964.561949092739;8159.755207343789;8895.154960278764;9119.498427586546;9149.862752058725;505.58541995563286;532.5819231902938;540.4298465119258;553.0432352031008;555.7526900529307;3827.10063135163;4010.2981978153707;4016.9397459038137;4073;4124.484439445069;89701.55149224213;90291.54854225818;90481.54759226162;91050;94146.52926735322;49422.25866612004;78633;80280.59859700664;81441.18558814336;82506;71380;72236;72302.2769772306;73094.26905730981;73734.26265737275;6970.616616086164;7208;7316.597587132759;7405.7778266652085;7539.283768042027;42189.367159493246;43517.3472397908;43675;44003.559964399945;45059.32411013903;35502.8224858874;48691;62947.6852615734;63553.364466354746;63684.3631563697;9725.270604704534;9753.80492390134;9904.306698531034;10011.349262297927;10076.798464030824;10562.630307939186;10647.627333043307;10681.359118452607;10908.072813810915;11308;9980.800383992424;10029.749256268651;10124.848127278245;10261.486925653538;10565.101966332948;9638.614455421985;9826.115649591286;9936.801263974536;10100.646477373257;10440.477976101316;9614.471204083842;9623.615055397986;9626.518674066408;9819;9973.052560006789;8652;8853.38026338176;8892.110788921056;8937.106289371011;9249.260059195114;8429.5785210738;8811.471311721318;8893.53256712635;8943;9030.32272579546 15:22:20 INFO - PROCESS | 5448 | __end_tp_report 15:22:20 INFO - PROCESS | 5448 | __start_cc_report 15:22:20 INFO - PROCESS | 5448 | _x_x_mozilla_cycle_collect,395 15:22:20 INFO - PROCESS | 5448 | __end_cc_report 15:22:20 INFO - PROCESS | 5448 | __startTimestamp1464906140150__endTimestamp 15:22:20 INFO - PROCESS | 5448 | 15:22:20 INFO - PROCESS | 5448 | ------- Summary: start ------- 15:22:20 INFO - PROCESS | 5448 | Number of tests: 6 15:22:20 INFO - PROCESS | 5448 | 15:22:20 INFO - PROCESS | 5448 | [#0] dojo.html Cycles:165 Average:4779.84 Median:4897.14 stddev:499.35 (10.2%) stddev-sans-first:472.17 15:22:20 INFO - PROCESS | 5448 | Values: 2652.7 2702.3 2726.2 2735.7 2747.4 4719.1 4742.1 4777.8 4832.6 4878.3 4738.1 4774.5 4848.6 4852.2 4897.1 4378.5 4403.3 4469.9 4482.8 4515.1 4171.8 4458.4 4523.4 4529.7 4565.3 4362.3 4393.5 4415.4 4431.0 4527.6 4332.7 4355.1 4445.2 4457.3 4476.8 4433.3 4434.5 4439.7 4480.3 4480.5 4575.8 4706.7 4707.0 4708.8 4741.5 5129.6 5146.4 5149.2 5158.7 5212.0 5153.0 5185.1 5186.9 5188.3 5198.0 4869.3 4872.2 4874.1 4892.2 4935.4 5337.1 5343.3 5358.9 5362.4 5365.2 4987.1 5030.9 5082.5 5082.8 5113.4 5019.7 5102.7 5108.1 5116.4 5130.3 5033.4 5092.6 5097.0 5112.6 5122.1 4958.2 5043.8 5100.5 5105.5 5109.5 4398.3 4399.0 4422.2 4432.4 4459.7 3813.4 3846.5 3852.8 3854.3 3876.3 4388.1 4498.5 4530.7 4533.1 4562.5 5241.2 5245.7 5249.2 5266.1 5277.3 4545.4 4557.0 4563.6 4573.7 4581.1 4571.7 4616.2 4619.6 4644.0 4745.4 4741.9 4793.5 4823.5 4827.1 4867.4 5155.9 5206.7 5208.2 5216.2 5257.8 4693.1 4805.3 4864.1 4884.8 4903.2 5163.9 5165.7 5166.8 5172.7 5226.7 5033.9 5248.1 5257.3 5259.4 5261.5 4958.2 5021.3 5028.2 5051.4 5077.4 5069.8 5100.5 5115.0 5115.3 5115.9 5026.1 5053.2 5053.4 5055.6 5084.8 4954.3 4992.5 5051.1 5057.1 5057.5 4918.9 4949.9 4951.3 4953.5 4997.3 15:22:20 INFO - PROCESS | 5448 | 15:22:20 INFO - PROCESS | 5448 | [#1] ext.html Cycles:180 Average:60545.35 Median:37714.91 stddev:129539.16 (343.5%) stddev-sans-first:129824.26 15:22:20 INFO - PROCESS | 5448 | Values: 561.5 601.0 606.5 615.4 619.4 35008.1 39474.2 39625.2 39684.4 39710.8 41096.0 41336.8 41688.8 41702.8 41759.4 7634.8 7782.1 7793.3 7810.0 7839.1 7664.1 7774.7 7779.2 7800.6 7806.3 7650.9 7722.4 7786.5 7796.3 7808.6 7733.9 7776.2 7782.6 7793.8 7802.7 7706.6 7712.3 7715.7 7791.3 7808.2 37705.0 37969.2 38163.2 38209.4 38254.2 2972.7 3007.3 3098.9 3386.9 3701.9 27274.9 29880.0 30110.4 30132.8 30136.7 3535.0 3561.3 3576.9 3592.6 3609.3 410414.0 416373.0 417082.0 417835.0 417944.0 56464.4 57405.4 57443.4 58065.8 58119.0 36124.3 62487.4 62584.4 62999.7 63031.4 15442.2 15628.8 15683.1 15706.1 15774.8 11705.3 11839.8 11870.7 11893.6 11907.8 18993.5 19040.3 19080.0 19093.2 19102.8 6920.8 7151.8 7234.1 7234.2 7359.3 848.7 849.3 939.5 994.7 1003.0 27905.4 28796.6 29159.3 29322.3 29753.7 1020.7 1022.7 1025.4 1039.8 1086.5 15011.5 15234.0 15285.7 15474.3 15616.7 381904.0 666321.0 680140.0 682006.0 683210.0 51791.2 51802.2 51961.5 52148.0 52151.5 1217.6 1240.2 1254.0 1255.6 1256.9 27771.4 29450.0 29612.0 30072.5 30119.7 45453.8 45712.1 45957.3 45965.8 46049.3 361785.0 362167.0 367096.0 369602.0 370404.0 25695.0 25966.9 26413.5 26758.1 26759.9 43398.3 43584.0 43705.6 43767.0 44435.8 36883.0 37694.4 37724.8 38105.8 38199.0 36343.3 37176.6 37447.4 37497.4 37702.6 36272.3 36442.3 36808.0 37215.8 37242.3 32732.5 33341.5 33673.0 33887.8 33967.5 25695.6 25824.5 26089.2 26095.5 26272.0 15:22:20 INFO - PROCESS | 5448 | 15:22:20 INFO - PROCESS | 5448 | [#2] jquery.html Cycles:180 Average:22873.23 Median:5158.17 stddev:61409.26 (1190.5%) stddev-sans-first:61558.26 15:22:20 INFO - PROCESS | 5448 | Values: 356.9 359.3 363.7 374.3 383.8 15576.9 16348.6 17315.3 17348.0 17506.0 16262.8 16331.3 17086.7 17237.0 17252.1 5058.7 5198.1 5237.6 5240.5 5250.6 3691.4 5107.5 5768.6 6058.4 6060.2 6038.8 6075.2 6077.2 6081.7 6083.8 4851.5 5155.0 5161.3 5218.1 5241.7 4975.5 5030.5 5049.2 5122.0 5137.6 11701.4 11765.8 11888.0 13192.0 19966.3 1714.2 1791.4 1808.1 1815.2 1909.0 8728.7 9143.4 9149.6 9179.5 9206.4 1730.2 1766.5 1793.5 1810.4 1845.3 68018.0 69384.7 70083.0 70809.0 71313.0 9448.9 9745.3 9750.0 9792.9 9926.2 13246.7 13272.7 13288.5 13323.5 13371.1 6937.8 7111.8 7141.8 7153.9 7195.7 6667.9 6973.9 6977.8 6997.8 7315.5 4013.1 4031.8 4078.0 4147.9 4161.3 1588.9 1613.5 1726.3 1750.3 1758.0 848.4 881.9 901.3 936.6 977.7 15663.7 15787.5 17607.2 17844.6 18010.2 838.8 846.0 880.4 923.9 928.9 9201.5 9306.4 9542.3 9568.0 9648.0 367440.0 371580.0 372400.0 372453.0 377690.0 48021.3 48086.0 72875.6 76409.6 77357.2 951.4 965.5 979.6 1000.1 1001.9 14953.2 14980.1 15062.6 15166.1 15390.5 24239.4 25286.2 35074.6 35522.3 35745.8 48200.0 49083.3 49277.3 49346.3 49381.5 4890.0 6782.7 7376.3 7531.4 7729.4 7735.5 10368.7 11139.1 11269.3 11403.3 9520.8 9624.9 9674.1 9831.8 9899.3 9599.7 9644.4 9843.2 9848.2 10062.5 4974.5 8571.5 9312.4 9316.3 9845.6 7261.7 7302.4 7334.8 7394.8 7497.4 8814.8 9478.5 9550.0 9733.0 9859.9 15:22:20 INFO - PROCESS | 5448 | 15:22:20 INFO - PROCESS | 5448 | [#3] mootools.html Cycles:180 Average:4690.28 Median:5727.47 stddev:2486.19 (43.4%) stddev-sans-first:2480.88 15:22:20 INFO - PROCESS | 5448 | Values: 1401.0 1422.1 1513.2 1702.8 1717.5 5899.8 6756.6 6769.6 7159.4 7163.2 6866.2 7078.2 7079.3 7091.2 7121.2 2050.9 2093.4 2096.1 2099.7 2102.3 2006.3 2014.6 2020.0 2046.4 2052.4 2077.2 2080.0 2090.2 2092.7 2098.7 1958.6 1965.6 1971.9 1972.6 1974.3 1950.2 1953.5 1967.6 1985.8 1993.3 7040.9 7062.9 7079.2 7104.8 7121.9 4211.9 4323.2 4334.1 4373.8 4400.2 2703.0 2796.4 2841.0 2863.3 2878.9 850.4 866.3 887.8 901.5 904.2 9146.3 9147.3 9193.4 9253.1 9259.3 3810.2 3855.6 3871.2 3904.3 3922.0 8151.6 8157.3 8173.5 8190.8 8200.2 4156.2 4157.9 4163.7 4168.9 4177.2 3374.8 3692.3 3820.6 3917.4 3964.2 3401.3 3406.3 3478.8 3493.5 3619.3 1062.8 1078.0 1081.2 1082.1 1101.3 844.4 861.6 879.0 879.7 890.7 5019.0 5050.8 5107.7 5213.3 5222.6 804.3 866.8 877.1 903.2 909.3 3526.5 3557.8 3618.5 3668.9 3687.6 7985.6 8193.2 8311.3 8332.1 8362.3 8246.1 8266.8 8277.7 8282.8 8304.0 6600.1 6739.3 6748.1 6782.7 6787.6 4898.3 5041.3 5125.8 5163.0 5231.7 7720.5 7830.5 7914.1 7918.5 7998.0 7515.2 7821.3 7822.8 7997.1 8053.2 5580.9 6103.3 6264.5 6468.4 6662.9 6493.1 6624.9 6632.4 6674.8 6687.4 6106.8 6169.9 6229.6 6328.3 6344.5 6130.6 6132.6 6212.0 6275.0 6293.9 5874.0 5985.1 5985.3 6010.0 6029.2 4252.0 4317.4 4346.0 4367.7 4396.6 4299.8 4381.1 4400.5 4444.0 4451.2 15:22:20 INFO - PROCESS | 5448 | 15:22:20 INFO - PROCESS | 5448 | [#4] prototype.html Cycles:180 Average:4287.58 Median:4758.38 stddev:1261.80 (26.5%) stddev-sans-first:1229.12 15:22:20 INFO - PROCESS | 5448 | Values: 288.2 290.6 297.7 301.1 301.3 4792.2 4922.7 5055.6 5065.6 5071.6 4977.5 4984.7 4996.8 5010.9 5020.8 3914.0 3916.2 3918.9 3924.3 3924.8 3695.4 3916.3 3923.5 3929.1 3940.2 3805.7 3837.2 3853.3 3855.0 3858.2 3869.5 3870.7 3882.0 3903.5 3905.7 3428.8 3431.2 3437.2 3444.8 3445.2 4579.7 4759.4 4759.5 4817.4 4839.8 4367.9 4385.7 4388.2 4410.6 4415.5 5205.1 5223.7 5233.2 5259.0 5278.4 3662.4 3732.9 3744.3 3763.2 3773.1 5523.8 5563.7 5577.6 5591.3 5592.3 3858.7 3889.3 3891.4 3905.1 3908.3 3957.9 3959.7 3970.3 3973.9 3999.7 4287.4 4423.2 4423.6 4424.8 4479.3 5220.6 5226.6 5239.7 5271.7 5289.3 1267.0 1334.2 1351.3 1356.9 1362.2 865.6 869.1 872.7 879.3 888.4 4130.7 4137.6 4141.9 4174.8 4196.3 4718.6 4748.3 4757.4 4775.4 4776.5 4198.8 4217.0 4222.0 4239.7 4246.8 2506.7 2561.2 2613.8 2618.8 2646.3 4492.2 4566.4 4581.8 4607.8 4608.7 4788.8 4895.6 4928.4 4945.4 4958.2 4566.5 4702.3 5050.4 5072.4 5089.9 5440.7 5454.0 5481.2 5492.7 5493.0 5268.9 5351.5 5366.0 5388.0 5418.9 5093.0 5099.6 5114.4 5116.6 5128.4 3702.3 3721.3 3735.6 3749.3 3767.3 5004.2 5382.9 5443.8 5463.4 5507.9 5295.9 5334.5 5344.3 5379.8 5399.3 5326.7 5335.7 5361.3 5369.2 5371.8 5077.0 5191.9 5244.6 5253.5 5295.7 5334.5 5348.8 5357.3 5402.5 5445.6 5207.7 5214.6 5232.1 5313.4 5354.9 15:22:20 INFO - PROCESS | 5448 | 15:22:20 INFO - PROCESS | 5448 | [#5] yui.html Cycles:180 Average:16936.53 Median:612.39 stddev:23847.87 (3894.2%) stddev-sans-first:23883.33 15:22:20 INFO - PROCESS | 5448 | Values: 626.8 687.7 697.9 701.1 759.4 12162.8 13202.7 13236.3 14808.1 15393.3 15080.5 15229.8 15240.6 15254.7 15309.7 632.9 785.9 813.6 825.0 827.1 802.2 807.0 808.8 810.3 810.5 861.7 862.5 865.4 868.9 870.5 862.7 862.9 863.2 863.8 864.1 632.9 633.7 633.7 634.2 634.4 14154.5 14426.0 14473.8 14477.6 14482.8 12217.0 12663.4 13153.1 13298.5 13329.5 10994.9 11077.3 11170.2 11237.8 11340.2 3367.4 3384.8 3414.5 3416.8 3481.8 62824.7 62999.7 63900.7 63989.4 64466.4 10316.0 10333.9 10375.8 10464.1 10515.9 19383.6 19392.7 19405.2 19451.8 19805.7 6864.9 6887.6 6979.9 6993.7 7063.9 3863.2 3867.4 3936.5 3941.1 3957.5 3042.4 3197.1 3200.5 3204.8 3210.6 495.4 497.5 500.7 502.2 509.0 475.2 493.7 556.7 592.4 598.0 7964.6 8159.8 8895.2 9119.5 9149.9 505.6 532.6 540.4 553.0 555.8 3827.1 4010.3 4016.9 4073.0 4124.5 89701.6 90291.5 90481.5 91050.0 94146.5 49422.3 78633.0 80280.6 81441.2 82506.0 71380.0 72236.0 72302.3 73094.3 73734.3 6970.6 7208.0 7316.6 7405.8 7539.3 42189.4 43517.3 43675.0 44003.6 45059.3 35502.8 48691.0 62947.7 63553.4 63684.4 9725.3 9753.8 9904.3 10011.3 10076.8 10562.6 10647.6 10681.4 10908.1 11308.0 9980.8 10029.7 10124.8 10261.5 10565.1 9638.6 9826.1 9936.8 10100.6 10440.5 9614.5 9623.6 9626.5 9819.0 9973.1 8652.0 8853.4 8892.1 8937.1 9249.3 8429.6 8811.5 8893.5 8943.0 9030.3 15:22:20 INFO - PROCESS | 5448 | -------- Summary: end -------- 15:22:20 INFO - PROCESS | 5448 | 15:22:20 INFO - TEST-INFO | 5448: exit 0 15:22:20 INFO - TEST-OK | dromaeo_css | took 1114994ms 15:22:20 INFO - TEST-START | kraken 15:22:20 INFO - operating with platform_type : linux_ 15:22:20 INFO - Initialising browser for kraken test... 15:22:20 INFO - TEST-INFO | started process 5687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpksyuFz/profile http://localhost:48585/getInfo.html) 15:22:25 INFO - PROCESS | 5687 | __metrics Screen width/height:1600/1200 15:22:25 INFO - PROCESS | 5687 | colorDepth:24 15:22:25 INFO - PROCESS | 5687 | Browser inner width/height: 1024/697 15:22:25 INFO - PROCESS | 5687 | __metrics 15:22:25 ERROR - PROCESS | 5687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 15:22:26 INFO - TEST-INFO | 5687: exit 0 15:22:26 INFO - Browser initialized. 15:22:26 INFO - Running cycle 1/1 for kraken test... 15:22:26 INFO - TEST-INFO | started process 5808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpksyuFz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:38 INFO - PROCESS | 5808 | RSS: Main: 168517632 15:22:38 INFO - PROCESS | 5808 | 15:22:41 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48585/tests/kraken/driver.html?testName=audio-beat-detection) 15:22:42 INFO - PROCESS | 5808 | RSS: Main: 172859392 15:22:42 INFO - PROCESS | 5808 | 15:22:45 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48585/tests/kraken/driver.html?testName=audio-dft) 15:22:45 INFO - PROCESS | 5808 | RSS: Main: 172560384 15:22:45 INFO - PROCESS | 5808 | 15:22:48 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48585/tests/kraken/driver.html?testName=audio-fft) 15:22:49 INFO - PROCESS | 5808 | RSS: Main: 167886848 15:22:49 INFO - PROCESS | 5808 | 15:22:51 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48585/tests/kraken/driver.html?testName=audio-oscillator) 15:22:52 INFO - PROCESS | 5808 | RSS: Main: 168607744 15:22:52 INFO - PROCESS | 5808 | 15:22:54 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48585/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:22:55 INFO - PROCESS | 5808 | RSS: Main: 168644608 15:22:55 INFO - PROCESS | 5808 | 15:22:58 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48585/tests/kraken/driver.html?testName=imaging-darkroom) 15:22:59 INFO - PROCESS | 5808 | RSS: Main: 169349120 15:22:59 INFO - PROCESS | 5808 | 15:23:02 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48585/tests/kraken/driver.html?testName=imaging-desaturate) 15:23:03 INFO - PROCESS | 5808 | RSS: Main: 166768640 15:23:03 INFO - PROCESS | 5808 | 15:23:06 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48585/tests/kraken/driver.html?testName=json-parse-financial) 15:23:06 INFO - PROCESS | 5808 | RSS: Main: 168665088 15:23:06 INFO - PROCESS | 5808 | 15:23:08 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48585/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:23:09 INFO - PROCESS | 5808 | RSS: Main: 169181184 15:23:09 INFO - PROCESS | 5808 | 15:23:11 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48585/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:23:11 INFO - PROCESS | 5808 | RSS: Main: 168808448 15:23:11 INFO - PROCESS | 5808 | 15:23:13 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48585/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:23:14 INFO - PROCESS | 5808 | RSS: Main: 169275392 15:23:14 INFO - PROCESS | 5808 | 15:23:17 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:23:18 INFO - PROCESS | 5808 | RSS: Main: 169648128 15:23:18 INFO - PROCESS | 5808 | 15:23:21 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:23:21 INFO - PROCESS | 5808 | RSS: Main: 168984576 15:23:21 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | Cycle 1(1): loaded http://localhost:48585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48585/tests/kraken/driver.html?testName=ai-astar) 15:23:23 INFO - PROCESS | 5808 | RSS: Main: 169979904 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | __start_tp_report 15:23:23 INFO - PROCESS | 5808 | _x_x_mozilla_page_load 15:23:23 INFO - PROCESS | 5808 | _x_x_mozilla_page_load_details 15:23:23 INFO - PROCESS | 5808 | |i|pagename|runs| 15:23:23 INFO - PROCESS | 5808 | |0;ai-astar;116;112;116;116;116;116;117;116;114;115 15:23:23 INFO - PROCESS | 5808 | |1;audio-beat-detection;163;132;158;182;131;170;157;131;191;131 15:23:23 INFO - PROCESS | 5808 | |2;audio-dft;165;163;165;175;161;164;164;164;164;162 15:23:23 INFO - PROCESS | 5808 | |3;audio-fft;78;76;79;160;77;79;75;76;167;76 15:23:23 INFO - PROCESS | 5808 | |4;audio-oscillator;90;85;138;86;85;85;141;85;85;130 15:23:23 INFO - PROCESS | 5808 | |5;imaging-gaussian-blur;118;118;117;117;118;117;119;119;118;119 15:23:23 INFO - PROCESS | 5808 | |6;imaging-darkroom;147;148;148;149;148;147;148;147;147;148 15:23:23 INFO - PROCESS | 5808 | |7;imaging-desaturate;96;96;96;96;96;95;95;95;95;95 15:23:23 INFO - PROCESS | 5808 | |8;json-parse-financial;64;65;65;65;65;66;65;64;72;68 15:23:23 INFO - PROCESS | 5808 | |9;json-stringify-tinderbox;66;66;66;66;65;66;65;65;65;65 15:23:23 INFO - PROCESS | 5808 | |10;stanford-crypto-aes;83;86;87;84;86;93;87;85;112;86 15:23:23 INFO - PROCESS | 5808 | |11;stanford-crypto-ccm;140;136;135;139;141;132;147;139;151;152 15:23:23 INFO - PROCESS | 5808 | |12;stanford-crypto-pbkdf2;171;173;180;182;180;170;177;177;170;174 15:23:23 INFO - PROCESS | 5808 | |13;stanford-crypto-sha256-iterative;68;69;71;68;68;68;70;67;67;69 15:23:23 INFO - PROCESS | 5808 | __end_tp_report 15:23:23 INFO - PROCESS | 5808 | __start_cc_report 15:23:23 INFO - PROCESS | 5808 | _x_x_mozilla_cycle_collect,948 15:23:23 INFO - PROCESS | 5808 | __end_cc_report 15:23:23 INFO - PROCESS | 5808 | __startTimestamp1464906203670__endTimestamp 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | ------- Summary: start ------- 15:23:23 INFO - PROCESS | 5808 | Number of tests: 14 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:1.43 (1.2%) stddev-sans-first:1.50 15:23:23 INFO - PROCESS | 5808 | Values: 116.0 112.0 116.0 116.0 116.0 116.0 117.0 116.0 114.0 115.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:160.50 stddev:22.56 (14.1%) stddev-sans-first:23.73 15:23:23 INFO - PROCESS | 5808 | Values: 163.0 132.0 158.0 182.0 131.0 170.0 157.0 131.0 191.0 131.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:3.83 (2.3%) stddev-sans-first:4.06 15:23:23 INFO - PROCESS | 5808 | Values: 165.0 163.0 165.0 175.0 161.0 164.0 164.0 164.0 164.0 162.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.50 stddev:36.53 (47.8%) stddev-sans-first:38.27 15:23:23 INFO - PROCESS | 5808 | Values: 78.0 76.0 79.0 160.0 77.0 79.0 75.0 76.0 167.0 76.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:85.00 stddev:24.58 (28.9%) stddev-sans-first:25.74 15:23:23 INFO - PROCESS | 5808 | Values: 90.0 85.0 138.0 86.0 85.0 85.0 141.0 85.0 85.0 130.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 15:23:23 INFO - PROCESS | 5808 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 119.0 119.0 118.0 119.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 15:23:23 INFO - PROCESS | 5808 | Values: 147.0 148.0 148.0 149.0 148.0 147.0 148.0 147.0 147.0 148.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:23:23 INFO - PROCESS | 5808 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:2.42 (3.7%) stddev-sans-first:2.47 15:23:23 INFO - PROCESS | 5808 | Values: 64.0 65.0 65.0 65.0 65.0 66.0 65.0 64.0 72.0 68.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 15:23:23 INFO - PROCESS | 5808 | Values: 66.0 66.0 66.0 66.0 65.0 66.0 65.0 65.0 65.0 65.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:86.00 stddev:8.54 (9.9%) stddev-sans-first:8.79 15:23:23 INFO - PROCESS | 5808 | Values: 83.0 86.0 87.0 84.0 86.0 93.0 87.0 85.0 112.0 86.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:140.50 stddev:6.73 (4.8%) stddev-sans-first:7.12 15:23:23 INFO - PROCESS | 5808 | Values: 140.0 136.0 135.0 139.0 141.0 132.0 147.0 139.0 151.0 152.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:177.00 stddev:4.43 (2.5%) stddev-sans-first:4.40 15:23:23 INFO - PROCESS | 5808 | Values: 171.0 173.0 180.0 182.0 180.0 170.0 177.0 177.0 170.0 174.0 15:23:23 INFO - PROCESS | 5808 | 15:23:23 INFO - PROCESS | 5808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.27 (1.9%) stddev-sans-first:1.33 15:23:23 INFO - PROCESS | 5808 | Values: 68.0 69.0 71.0 68.0 68.0 68.0 70.0 67.0 67.0 69.0 15:23:23 INFO - PROCESS | 5808 | -------- Summary: end -------- 15:23:23 INFO - PROCESS | 5808 | 15:23:24 INFO - TEST-INFO | 5808: exit 0 15:23:24 INFO - TEST-OK | kraken | took 63788ms 15:23:24 INFO - SUITE-END | took 1178s 15:23:24 INFO - Completed test suite (00:19:38) 15:23:24 INFO - javascript benchmark 15:23:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6370.223997744006, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.681678198616, 2702.283894767886, 2726.236653736953, 2735.726427357263, 2747.395572973945, 4719.126961512118, 4742.122707299152, 4777.8088876444945, 4832.639732382876, 4878.29264756611, 4738.052389522092, 4774.49867763885, 4848.587870031043, 4852.247901575252, 4897.142999974999, 4378.540253273401, 4403.273459879116, 4469.9106017879785, 4482.843100491484, 4515.074409746011, 4171.770552619605, 4458.4426946631675, 4523.389342438762, 4529.705569138012, 4565.292379681138, 4362.345648152771, 4393.472783265996, 4415.359772832953, 4431.047324825178, 4527.615152712024, 4332.67504937131, 4355.128974205171, 4445.199864024475, 4457.28683410656, 4476.776161191928, 4433.312836510346, 4434.512203657595, 4439.667024973108, 4480.305552639346, 4480.529544397824, 4575.794089265991, 4706.670533062687, 4707.0, 4708.788104535304, 4741.478437371887, 5129.563987061104, 5146.433892271847, 5149.176131818891, 5158.716270605115, 5211.973940130313, 5152.974235128838, 5185.144451165553, 5186.948130518722, 5188.325517682715, 5198.0, 4869.269609558523, 4872.196087645499, 4874.073925954058, 4892.192788189945, 4935.407751069859, 5337.146056630921, 5343.251944727741, 5358.866028349323, 5362.436944120811, 5365.248865158881, 4987.127252730757, 5030.949690503048, 5082.517160869711, 5082.822101226439, 5113.411957624847, 5019.723915184627, 5102.744862756847, 5108.106081435734, 5116.437191908887, 5130.307408499804, 5033.446320904697, 5092.592592592584, 5097.0315640028275, 5112.642115051911, 5122.129238029544, 4958.181899986534, 5043.823466178666, 5100.515451032146, 5105.540501354896, 5109.463506331782, 4398.252297109499, 4398.956010439919, 4422.226110430662, 4432.3794668746405, 4459.687821852439, 3813.389857622767, 3846.4614953906475, 3852.8266228019247, 3854.2869569129803, 3876.2635099331037, 4388.1223755249075, 4498.482674492409, 4530.682852200314, 4533.138703646297, 4562.475315338712, 5241.213817927342, 5245.7114858683135, 5249.186376111708, 5266.052110620125, 5277.287566178594, 4545.36364908913, 4557.0, 4563.573610897906, 4573.748443835554, 4581.129585378767, 4571.748553829571, 4616.192166370939, 4619.5611416915335, 4643.953560464352, 4745.383100197021, 4741.857744267678, 4793.472718001017, 4823.493533178966, 4827.08285425768, 4867.440244371943, 5155.948440515547, 5206.713630750345, 5208.244804503402, 5216.191490319006, 5257.763400647056, 4693.084848454519, 4805.327254184347, 4864.100141473838, 4884.8290309838985, 4903.16646170159, 5163.922541161811, 5165.741712914414, 5166.819161329486, 5172.663776854492, 5226.660267082628, 5033.899322013466, 5248.1340578804065, 5257.2902658140665, 5259.368875734936, 5261.473852614861, 4958.181899986606, 5021.322121513549, 5028.245763135413, 5051.419086805065, 5077.416097148727, 5069.822556210515, 5100.48995100487, 5114.977004599169, 5115.25828754821, 5115.9232611510115, 5026.095302845523, 5053.2420136979745, 5053.418856831511, 5055.646104772778, 5084.8220312288895, 4954.3311652926395, 4992.525710057539, 5051.116054690341, 5057.089723849743, 5057.494250574913, 4918.852434426973, 4949.901001980013, 4951.257311403318, 4953.455119936876, 4997.275395067768], "value": 4748.2227506009585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.539537579185, 601.0173366545698, 606.4723690389359, 615.4030590327383, 619.4363129552108, 35008.12479688006, 39474.210515789666, 39625.20749585007, 39684.404733928975, 39710.8014459928, 41096.0, 41336.79331603338, 41688.791556042175, 41702.7914860426, 41759.37360939589, 7634.809129771758, 7782.143964163937, 7793.2596403341595, 7809.960950195241, 7839.137694853562, 7664.118626357985, 7774.727884524043, 7779.222077792204, 7800.570968596725, 7806.297433231008, 7650.885236721426, 7722.420818438612, 7786.454948153631, 7796.298333150015, 7808.60956952153, 7733.9226607734045, 7776.222377762235, 7782.64978075988, 7793.76618701437, 7802.68789248435, 7706.576138312391, 7712.267334603203, 7715.729949451742, 7791.259830316168, 7808.180141085161, 37705.0, 37969.24061518782, 38163.23673526514, 38209.426858597144, 38254.234915301815, 2972.7175918287726, 3007.323352245727, 3098.922526936822, 3386.881459148918, 3701.8704345347783, 27274.863625681945, 29880.0, 30110.397792044256, 30132.84933575318, 30136.698633013828, 3535.045537704805, 3561.3055454186183, 3576.91057723559, 3592.6407359264126, 3609.260101679176, 410414.0, 416373.0, 417082.0, 417835.0, 417944.0, 56464.43535564674, 57405.42594574084, 57443.42556574464, 58065.806380648624, 58119.0, 36124.27751445009, 62487.37512624815, 62584.37415625877, 62999.68500157561, 63031.36968630255, 15442.22788860575, 15628.843711562738, 15683.1374274416, 15706.057636541844, 15774.842251577338, 11705.297682139098, 11839.822402663967, 11870.703232419086, 11893.643190704293, 11907.761844763056, 18993.525161871064, 19040.333588324618, 19080.0, 19093.2362705493, 19102.80897191038, 6920.826979325557, 7151.7854464366155, 7234.131904171533, 7234.168070671835, 7359.30735930739, 848.7114381110453, 849.2781136034322, 939.4926739560698, 994.7015895231401, 1003.0320740485466, 27905.441891162063, 28796.568051479244, 29159.271018224714, 29322.26694332616, 29753.702462975525, 1020.6682828080903, 1022.6829682798357, 1025.36939782035, 1039.8440233964966, 1086.4947799273375, 15011.549653510412, 15234.0, 15285.694286114216, 15474.303656335493, 15616.687666246611, 381904.0, 666321.0, 680140.0, 682006.0, 683210.0, 51791.22313165305, 51802.22296665553, 51961.48038519642, 52147.95704085897, 52151.47848521466, 1217.598192596441, 1240.2124650846597, 1254.021862946903, 1255.554278231233, 1256.9183003104952, 27771.44457110887, 29450.0, 29612.0, 30072.5489117659, 30119.698803012565, 45453.772731137455, 45712.08575828531, 45957.31064034109, 45965.77017114893, 46049.30926036045, 361785.0, 362167.0, 367096.0, 369602.0, 370404.0, 25695.0, 25966.92264618864, 26413.471730564896, 26758.063467778535, 26759.929602815668, 43398.34902476529, 43584.0, 43705.56294437015, 43767.0, 44435.777821110685, 36883.0, 37694.434583480725, 37724.81137594295, 38105.80947095247, 38199.0, 36343.273134536634, 37176.62823371732, 37447.43828842624, 37497.437538437494, 37702.62297376991, 36272.27455450929, 36442.27115457729, 36808.0, 37215.813920930224, 37242.25515489729, 32732.50901236531, 33341.499877501374, 33673.0, 33887.83056084704, 33967.4904876432, 25695.614565781154, 25824.48351032931, 26089.217323480327, 26095.478090438464, 26272.0], "value": 18637.933893782392, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.88579654510556, 359.30115924526797, 363.6527116603642, 374.3374227617116, 383.81001404304874, 15576.922115389421, 16348.591285217875, 17315.307387704477, 17348.045857477835, 17506.037167955757, 16262.75605865913, 16331.265093070811, 17086.658266834656, 17237.0, 17252.137393130324, 5058.69647821131, 5198.116320225552, 5237.633365664405, 5240.528352448279, 5250.606204534656, 3691.427828686558, 5107.540321371076, 5768.567357448187, 6058.394160583928, 6060.2424696912885, 6038.818835434944, 6075.210222671047, 6077.24034495688, 6081.665508397036, 6083.78706745264, 4851.539103785135, 5155.046316431453, 5161.30322406476, 5218.086834803894, 5241.685498870042, 4975.4527002029745, 5030.471800460936, 5049.192129259301, 5121.974390128063, 5137.6403651744395, 11701.3564253966, 11765.823512647317, 11888.048956083492, 13192.0, 19966.30117945865, 1714.1686282153146, 1791.3730194431976, 1808.0688445450603, 1815.155952482102, 1908.9618207635908, 8728.650853965833, 9143.405678630868, 9149.588268527865, 9179.541022948826, 9206.447613143166, 1730.221400369826, 1766.4788887278285, 1793.5426466251154, 1810.3663717698832, 1845.2895635180419, 68018.0, 69384.65307673429, 70083.0, 70809.0, 71313.0, 9448.90551094494, 9745.31782775199, 9750.0, 9792.902070979198, 9926.2059035277, 13246.73506529864, 13272.668183295495, 13288.534901278408, 13323.533676321476, 13371.06402551812, 6937.7571784987285, 7111.751088711871, 7141.750038748619, 7153.89269160963, 7195.676194571152, 6667.86664266712, 6973.919042548413, 6977.755778547727, 6997.825054373681, 7315.524490908074, 4013.1171142348635, 4031.8387264509092, 4078.0, 4147.8963025924595, 4161.271777438936, 1588.896721713108, 1613.5159452164303, 1726.3008481564987, 1750.2998800479656, 1758.0485660916372, 848.3976376772438, 881.9073997230198, 901.2699713232303, 936.6159874451442, 977.6578197630772, 15663.68672626541, 15787.526374208792, 17607.207675654627, 17844.643107138043, 18010.189541470667, 838.8490071787015, 846.0439703135418, 880.3881302494833, 923.8706581078654, 928.8653145293895, 9201.49391783445, 9306.441613503212, 9542.280450071696, 9568.0, 9647.951760241154, 367440.0, 371580.0, 372400.0, 372453.0, 377690.0, 48021.279680804815, 48086.0, 72875.63562182155, 76409.61795190988, 77357.22642773612, 951.4481600671594, 965.5461932891529, 979.6179489999049, 1000.1099021870396, 1001.8597396364515, 14953.177575233467, 14980.1011939284, 15062.623434414227, 15166.090034597959, 15390.461333853262, 24239.394015149763, 25286.24141275765, 35074.64925350714, 35522.28955420929, 35745.82127089348, 48200.0, 49083.26375104448, 49277.26084108813, 49346.25980610222, 49381.506184937694, 4890.0, 6782.69477873487, 7376.336129748348, 7531.3974882008215, 7729.4202934779, 7735.497192682457, 10368.703912010998, 11139.108871290115, 11269.323840569592, 11403.315801051964, 9520.761980950532, 9624.855627165458, 9674.129328360481, 9831.803363932824, 9899.307048506535, 9599.664011759554, 9644.421334719938, 9843.212542996685, 9848.212143028684, 10062.547185376821, 4974.477679843564, 8571.528565928933, 9312.394694344846, 9316.254699624149, 9845.606175753177, 7261.709531618676, 7302.379297759538, 7334.779956601311, 7394.7781566553085, 7497.370087298293, 8814.779630509289, 9478.478683672189, 9549.997250288898, 9733.0, 9859.852102218616], "value": 7843.482894643613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.0262867307222, 1422.11118051218, 1513.1904431129349, 1702.8382303681146, 1717.5019244419118, 5899.823005309837, 6756.628385438799, 6769.5599786014, 7159.427245820335, 7163.212046674862, 6866.176058872942, 7078.186008609012, 7079.327463890922, 7091.219965803757, 7121.216666166718, 2050.897455127245, 2093.42430831521, 2096.1091536097174, 2099.737532808399, 2102.3482720356737, 2006.3178519303433, 2014.6272939506239, 2019.9899000504977, 2046.4270004398793, 2052.384284714587, 2077.1795140919326, 2080.0431801371387, 2090.216168936649, 2092.7279453671076, 2098.7481502219757, 1958.5789055353025, 1965.5872266823985, 1971.9014049297477, 1972.6350625134396, 1974.3188599933, 1950.1516840174427, 1953.5116220944765, 1967.5868067705799, 1985.8014198580026, 1993.2624928776445, 7040.859182816315, 7062.894056589155, 7079.150501939749, 7104.822379440556, 7121.89317160243, 4211.915761684749, 4323.178596066738, 4334.089841133366, 4373.825046998148, 4400.185965596343, 2702.9594556081674, 2796.3708165662765, 2841.0482488366424, 2863.2698661841305, 2878.9280267993468, 850.408965768791, 866.3242670716851, 887.7514295997131, 901.4951627088851, 904.1500989070319, 9146.314026448043, 9147.313951453601, 9193.448393096369, 9253.074692530694, 9259.259259259243, 3810.2189051244427, 3855.556610989716, 3871.2064026874423, 3904.316744569689, 3922.0, 8151.633176507072, 8157.265846073882, 8173.509589424653, 8190.836183276301, 8200.179982001751, 4156.231097247019, 4157.91684166315, 4163.687723420695, 4168.916621667549, 4177.185448837447, 3374.814385208837, 3692.280005398975, 3820.56063552695, 3917.4319723639915, 3964.2467931093, 3401.2687272236094, 3406.267652454734, 3478.756487045933, 3493.5458390409085, 3619.3485172668647, 1062.824633935392, 1077.978440431187, 1081.1566977757361, 1082.09644946469, 1101.2566517600587, 844.3582877013391, 861.6467248428114, 878.9956050219708, 879.692107762278, 890.7238755985666, 5018.974905125524, 5050.823221187241, 5107.719075450812, 5213.2701421800975, 5222.556082732935, 804.284187073505, 866.7659731872485, 877.0965905117739, 903.2367649336301, 909.2589539525397, 3526.506289119474, 3557.7509574330065, 3618.457231415256, 3668.926621467556, 3687.59436461989, 7985.600719963979, 8193.180681931759, 8311.293540049042, 8332.125126861714, 8362.331013518904, 8246.05170405399, 8266.834663306821, 8277.710280140167, 8282.751517454486, 8303.95848020756, 6600.108985287021, 6739.258681545026, 6748.089007983859, 6782.660866956534, 6787.5588086774205, 4898.289747986593, 5041.294218809297, 5125.846224613268, 5163.044836705221, 5231.6860988339295, 7720.53676779395, 7830.451868369388, 7914.089879663912, 7918.485298455582, 7998.040235171817, 7515.173330933702, 7821.296083352526, 7822.843543129219, 7997.080335761462, 8053.154418785943, 5580.944190558205, 6103.267607887082, 6264.467520260829, 6468.417842394207, 6662.900056499059, 6493.123428337114, 6624.9337506624315, 6632.436242919406, 6674.799756007327, 6687.364700353459, 6106.816795496142, 6169.876602468015, 6229.595076320024, 6328.272248691459, 6344.492440604833, 6130.601510901777, 6132.63204207749, 6212.0371342441995, 6275.0, 6293.937060629335, 5874.0, 5985.132155837292, 5985.341612422543, 6010.0, 6029.246344206974, 4251.95748042528, 4317.417148684887, 4345.956540434555, 4367.71152510004, 4396.560343965578, 4299.849505267301, 4381.079973205535, 4400.471943366816, 4443.977780111079, 4451.198784218872], "value": 3852.3463676136653, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.1628868138058, 290.6178375436301, 297.6918888949936, 301.10571602341054, 301.2919638848707, 4792.185328494155, 4922.70463772173, 5055.620828437868, 5065.645404821664, 5071.568916642085, 4977.527134922186, 4984.725840078794, 4996.825111121111, 5010.874728131798, 5020.849374518762, 3914.0, 3916.1971795781938, 3918.8628398006076, 3924.274009308273, 3924.803759812005, 3695.3902606069964, 3916.2559113768293, 3923.5487918889407, 3929.0766669832565, 3940.2316548272956, 3805.676517496016, 3837.194189220267, 3853.344931361661, 3854.9807250963704, 3858.2283543291455, 3869.496965394509, 3870.6516413522777, 3881.9611803882162, 3903.4535165077054, 3905.7461265017682, 3428.777129486575, 3431.1936694876686, 3437.1750779812915, 3444.7588668793196, 3445.2248244145117, 4579.748113853737, 4759.357486739281, 4759.4764575896625, 4817.397825271841, 4839.806407743686, 4367.934480982788, 4385.693001489897, 4388.188185185719, 4410.62509686677, 4415.51429342772, 5205.063088644042, 5223.738813059332, 5233.1888557273305, 5259.0, 5278.392984806719, 3662.359087159736, 3732.9440058399146, 3744.307303148926, 3763.209725957552, 3773.113318370181, 5523.806666766684, 5563.693996830173, 5577.637453565505, 5591.294655130184, 5592.273004509429, 3858.6720128789366, 3889.3388124018984, 3891.3968334908136, 3905.1213476967455, 3908.335582950905, 3957.8614748483665, 3959.742616729903, 3970.344893092665, 3973.8609148679657, 3999.680025597945, 4287.356896465555, 4423.203823311835, 4423.5576442355505, 4424.778761061998, 4479.260921947842, 5220.556252718561, 5226.608004399685, 5239.711815850165, 5271.710055946883, 5289.259503669489, 1267.0370518406078, 1334.1728128560355, 1351.2635613590421, 1356.85752995936, 1362.2167253829089, 865.5801936061006, 869.1004810021598, 872.7432497204006, 879.2833840420037, 888.3870129610548, 4130.657536300714, 4137.648299894482, 4141.875743727693, 4174.83300667976, 4196.328587425997, 4718.598919091847, 4748.264019077049, 4757.405324334458, 4775.403074615673, 4776.519279023514, 4198.782353117623, 4217.0, 4221.97889010553, 4239.745615263094, 4246.8301267949555, 2506.749325067479, 2561.1932241343916, 2613.7908967282574, 2618.751218634227, 2646.325187077283, 4492.213862574036, 4566.383538222364, 4581.816727330936, 4607.815687372535, 4608.677392582487, 4788.832390866303, 4895.632827537949, 4928.408590969107, 4945.4312754033745, 4958.231474121517, 4566.543345665474, 4702.318163866289, 5050.419201791841, 5072.391313042459, 5089.923651145235, 5440.700761458158, 5453.972730136324, 5481.150421684645, 5492.697901615449, 5493.0, 5268.894622107459, 5351.491608297206, 5366.0, 5387.973060134675, 5418.918716219181, 5092.955944031539, 5099.643024988363, 5114.360704911886, 5116.590672746246, 5128.384593848762, 3702.315071711742, 3721.292954338667, 3735.5704094029534, 3749.2501499699624, 3767.3218820611455, 5004.249362595494, 5382.892342153214, 5443.8153680097585, 5463.399026107046, 5507.889842203213, 5295.894082118259, 5334.493223143795, 5344.305240318734, 5379.789547351815, 5399.325084364455, 5326.7336633167415, 5335.706536140549, 5361.329833770778, 5369.167778994262, 5371.838844834661, 5076.974615126901, 5191.922121168261, 5244.554212891947, 5253.50091741284, 5295.655782374288, 5334.532553840035, 5348.839534813962, 5357.330333708286, 5402.51377376038, 5445.584148121596, 5207.739613019258, 5214.582833373245, 5232.136697445031, 5313.415524292247, 5354.866128346823], "value": 3884.815534090775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.7868924565647, 687.6596084937953, 697.9127609048868, 701.1340993872569, 759.3697231298023, 12162.81755773663, 13202.669933251673, 13236.338183090844, 14808.11151330921, 15393.307301171446, 15080.472183473581, 15229.847701522982, 15240.618984525392, 15254.694906101871, 15309.69380612387, 632.8512799492139, 785.9331956783681, 813.5769399912057, 824.9876251856197, 827.0943317067802, 802.2458888644655, 807.0355924670022, 808.7695006923028, 810.3193317613204, 810.5460941872541, 861.7113267055544, 862.5083702289666, 865.3899001204136, 868.8696695495663, 870.5212133326677, 862.7239283429274, 862.9352798540103, 863.2489733931457, 863.8185980943947, 864.1142828600703, 632.9303776584572, 633.6989929783363, 633.7053270229366, 634.2199095112991, 634.3592971099177, 14154.50459233932, 14426.0, 14473.78289325661, 14477.638059048502, 14482.782758258634, 12217.0, 12663.430145643468, 13153.145045572008, 13298.468061277537, 13329.466821327233, 10994.890051099546, 11077.335359878432, 11170.218084734071, 11237.83143252852, 11340.206185567014, 3367.4107031269673, 3384.76306658534, 3414.5219669246326, 3416.829158542063, 3481.8433170507387, 62824.68587657032, 62999.685001575155, 63900.680496597684, 63989.3601063988, 64466.35533644697, 10316.0, 10333.896661033445, 10375.792484150426, 10464.110550603284, 10515.94742026285, 19383.612327753366, 19392.70910936337, 19405.223791048484, 19451.80548194528, 19805.702914456295, 6864.862702745917, 6887.586744795329, 6979.89530157048, 6993.685284162225, 7063.89404158938, 3863.2273545291055, 3867.439221312894, 3936.5079365079364, 3941.1132495188353, 3957.5250969883223, 3042.3763128558594, 3197.0728488738005, 3200.4719221328687, 3204.759643026782, 3210.646828848825, 495.40798745498785, 497.4950425318305, 500.684568721703, 502.21904937822035, 508.9618278629118, 475.2396166134227, 493.7235148316954, 556.7084364274924, 592.404633343487, 598.0, 7964.561949092739, 8159.755207343789, 8895.154960278764, 9119.498427586546, 9149.862752058725, 505.58541995563286, 532.5819231902938, 540.4298465119258, 553.0432352031008, 555.7526900529307, 3827.10063135163, 4010.2981978153707, 4016.9397459038137, 4073.0, 4124.484439445069, 89701.55149224213, 90291.54854225818, 90481.54759226162, 91050.0, 94146.52926735322, 49422.25866612004, 78633.0, 80280.59859700664, 81441.18558814336, 82506.0, 71380.0, 72236.0, 72302.2769772306, 73094.26905730981, 73734.26265737275, 6970.616616086164, 7208.0, 7316.597587132759, 7405.7778266652085, 7539.283768042027, 42189.367159493246, 43517.3472397908, 43675.0, 44003.559964399945, 45059.32411013903, 35502.8224858874, 48691.0, 62947.6852615734, 63553.364466354746, 63684.3631563697, 9725.270604704534, 9753.80492390134, 9904.306698531034, 10011.349262297927, 10076.798464030824, 10562.630307939186, 10647.627333043307, 10681.359118452607, 10908.072813810915, 11308.0, 9980.800383992424, 10029.749256268651, 10124.848127278245, 10261.486925653538, 10565.101966332948, 9638.614455421985, 9826.115649591286, 9936.801263974536, 10100.646477373257, 10440.477976101316, 9614.471204083842, 9623.615055397986, 9626.518674066408, 9819.0, 9973.052560006789, 8652.0, 8853.38026338176, 8892.110788921056, 8937.106289371011, 9249.260059195114, 8429.5785210738, 8811.471311721318, 8893.53256712635, 8943.0, 9030.32272579546], "value": 6431.93389336963, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 114.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 158.0, 182.0, 131.0, 170.0, 157.0, 131.0, 191.0, 131.0], "value": 154.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 175.0, 161.0, 164.0, 164.0, 164.0, 164.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 79.0, 160.0, 77.0, 79.0, 75.0, 76.0, 167.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 138.0, 86.0, 85.0, 85.0, 141.0, 85.0, 85.0, 130.0], "value": 101.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 119.0, 119.0, 118.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 149.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 72.0, 68.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 87.0, 84.0, 86.0, 93.0, 87.0, 85.0, 112.0, 86.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 135.0, 139.0, 141.0, 132.0, 147.0, 139.0, 151.0, 152.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 180.0, 182.0, 180.0, 170.0, 177.0, 177.0, 170.0, 174.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 71.0, 68.0, 68.0, 68.0, 70.0, 67.0, 67.0, 69.0], "value": 68.5, "unit": "score"}]}]} 15:23:24 INFO - Return code: 0 15:23:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:23:24 ERROR - # TBPL SUCCESS # 15:23:24 INFO - Running post-action listener: _resource_record_post_action 15:23:24 INFO - ##### 15:23:24 INFO - ##### Finished run-tests step (success) 15:23:24 INFO - ##### 15:23:24 INFO - Running post-run listener: _resource_record_post_run 15:23:25 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530255872; Read time: 12; Write time: 456352 15:23:25 INFO - TinderboxPrint: CPU usage
13.5% 15:23:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:23:25 INFO - TinderboxPrint: I/O write bytes / time
530,255,872 / 456,352 15:23:25 INFO - TinderboxPrint: CPU idle
8,256.7 (86.5%) 15:23:25 INFO - TinderboxPrint: CPU user
1,233.6 (12.9%) 15:23:25 INFO - TinderboxPrint: Swap in / out
0 / 0 15:23:25 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244977664; Read time: 0; Write time: 258196 15:23:25 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285278208; Read time: 12; Write time: 198156 15:23:25 INFO - Running post-run listener: _upload_blobber_files 15:23:25 INFO - Blob upload gear active. 15:23:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:23:25 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 15:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:23:25 INFO - (blobuploader) - INFO - Open directory for files ... 15:23:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:23:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:23:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:27 INFO - (blobuploader) - INFO - Done attempting. 15:23:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:23:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:23:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:27 INFO - (blobuploader) - INFO - Done attempting. 15:23:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:23:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:23:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:32 INFO - (blobuploader) - INFO - Done attempting. 15:23:32 INFO - (blobuploader) - INFO - Iteration through files over. 15:23:32 INFO - Return code: 0 15:23:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:23:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:23:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/026064fd4201cddcb46cae8aeda59385847b0fee567aaaf2b9cd1972ce1adb2db0291211103787983a8549281d9ce5c585c5aad9a1d8cc8a93acd6ea14addc77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f565f8d75c9df99720fd6c0186ed1f8f4ebe88bacbc32418bae2d8160d313270712fe0e0c593b1c0d6cd0baf356ad1870a65a5fde173b4a9eeca9557e9b084a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb69b7253c2b295e962218bc137066858dc106db3999a2476e9446ee6e2b45449966539e4d8eff47b1f1f4e6beebdc69b6000d55fb531f26e86d269a40480828"} 15:23:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:23:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:23:32 INFO - Contents: 15:23:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/026064fd4201cddcb46cae8aeda59385847b0fee567aaaf2b9cd1972ce1adb2db0291211103787983a8549281d9ce5c585c5aad9a1d8cc8a93acd6ea14addc77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f565f8d75c9df99720fd6c0186ed1f8f4ebe88bacbc32418bae2d8160d313270712fe0e0c593b1c0d6cd0baf356ad1870a65a5fde173b4a9eeca9557e9b084a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb69b7253c2b295e962218bc137066858dc106db3999a2476e9446ee6e2b45449966539e4d8eff47b1f1f4e6beebdc69b6000d55fb531f26e86d269a40480828"} 15:23:32 INFO - Running post-run listener: copy_logs_to_upload_dir 15:23:32 INFO - Copying logs to upload dir... 15:23:32 INFO - mkdir: /builds/slave/test/build/upload/logs 15:23:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.607523 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-02 15:23:32.389114) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 15:23:32.393160) ========= 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=0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/026064fd4201cddcb46cae8aeda59385847b0fee567aaaf2b9cd1972ce1adb2db0291211103787983a8549281d9ce5c585c5aad9a1d8cc8a93acd6ea14addc77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f565f8d75c9df99720fd6c0186ed1f8f4ebe88bacbc32418bae2d8160d313270712fe0e0c593b1c0d6cd0baf356ad1870a65a5fde173b4a9eeca9557e9b084a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb69b7253c2b295e962218bc137066858dc106db3999a2476e9446ee6e2b45449966539e4d8eff47b1f1f4e6beebdc69b6000d55fb531f26e86d269a40480828"} build_url:https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/HV_oakX4RmuBOFp4QcYugQ/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-Non-PGO/sha512/026064fd4201cddcb46cae8aeda59385847b0fee567aaaf2b9cd1972ce1adb2db0291211103787983a8549281d9ce5c585c5aad9a1d8cc8a93acd6ea14addc77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f565f8d75c9df99720fd6c0186ed1f8f4ebe88bacbc32418bae2d8160d313270712fe0e0c593b1c0d6cd0baf356ad1870a65a5fde173b4a9eeca9557e9b084a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb69b7253c2b295e962218bc137066858dc106db3999a2476e9446ee6e2b45449966539e4d8eff47b1f1f4e6beebdc69b6000d55fb531f26e86d269a40480828"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 15:23:32.418891) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:23:32.419208) ========= 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=0333a256a5e4f052382dd180000001b1-1464904971.423543-463714936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 15:23:32.502903) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 15:23:32.503229) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 15:23:32.503521) ========= ========= Total master_lag: 0.16 =========