builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1456936683.38 results: success (0) buildid: 20160302073621 builduid: a69e6e394cc24caabb52a0a7d196bfbd revision: 5bfead86cc6c7cdfe68fb584789b83c87b2c3bf2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.385349) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.385825) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.386139) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006407 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.444438) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.444718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.508318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.508596) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.558561) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.558875) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.559252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.559791) ========= 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=6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-02 08:38:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.7M=0.001s 2016-03-02 08:38:05 (20.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.737545) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.737877) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014715 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.788708) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:03.789097) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5bfead86cc6c7cdfe68fb584789b83c87b2c3bf2 --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 5bfead86cc6c7cdfe68fb584789b83c87b2c3bf2 --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=6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-02 08:38:05,115 truncating revision to first 12 chars 2016-03-02 08:38:05,115 Setting DEBUG logging. 2016-03-02 08:38:05,115 attempt 1/10 2016-03-02 08:38:05,115 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5bfead86cc6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 08:38:05,372 unpacking tar archive at: fx-team-5bfead86cc6c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585000 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:04.387571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:04.387922) ========= echo 5bfead86cc6c7cdfe68fb584789b83c87b2c3bf2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5bfead86cc6c7cdfe68fb584789b83c87b2c3bf2'] 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=6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5bfead86cc6c7cdfe68fb584789b83c87b2c3bf2 program finished with exit code 0 elapsedTime=0.003749 script_repo_revision: '5bfead86cc6c7cdfe68fb584789b83c87b2c3bf2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:04.436677) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:04.437093) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 08:38:04.447598) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-02 08:38:04.447995) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:38:05 INFO - MultiFileLogger online at 20160302 08:38:05 in /builds/slave/test 08:38:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 08:38:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:38:05 INFO - {'append_to_log': False, 08:38:05 INFO - 'base_work_dir': '/builds/slave/test', 08:38:05 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:38:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:38:05 INFO - 'branch': 'Fx-Team-Non-PGO', 08:38:05 INFO - 'buildbot_json_path': 'buildprops.json', 08:38:05 INFO - 'config_files': ('talos/linux_config.py',), 08:38:05 INFO - 'default_actions': ('clobber', 08:38:05 INFO - 'read-buildbot-config', 08:38:05 INFO - 'download-and-extract', 08:38:05 INFO - 'populate-webroot', 08:38:05 INFO - 'create-virtualenv', 08:38:05 INFO - 'install', 08:38:05 INFO - 'run-tests'), 08:38:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:38:05 INFO - 'download_minidump_stackwalk': True, 08:38:05 INFO - 'download_symbols': 'ondemand', 08:38:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:38:05 INFO - 'tooltool.py': '/tools/tooltool.py', 08:38:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:38:05 INFO - '/tools/misc-python/virtualenv.py')}, 08:38:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:38:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:38:05 INFO - 'installer_path': 'installer.exe', 08:38:05 INFO - 'log_level': 'info', 08:38:05 INFO - 'log_name': 'talos', 08:38:05 INFO - 'log_to_console': True, 08:38:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:38:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:38:05 INFO - 'opt_config_files': (), 08:38:05 INFO - 'pip_index': False, 08:38:05 INFO - 'sps_profile': False, 08:38:05 INFO - 'sps_profile_interval': 0, 08:38:05 INFO - 'suite': 'dromaeojs', 08:38:05 INFO - 'system_bits': '32', 08:38:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:38:05 INFO - 'title': 'talos-linux64-ix-050', 08:38:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:38:05 INFO - 'use_talos_json': True, 08:38:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:38:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:38:05 INFO - 'work_dir': 'build'} 08:38:05 INFO - ##### 08:38:05 INFO - ##### Running clobber step. 08:38:05 INFO - ##### 08:38:05 INFO - Running pre-action listener: _resource_record_pre_action 08:38:05 INFO - Running main action method: clobber 08:38:05 INFO - rmtree: /builds/slave/test/build 08:38:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:38:06 INFO - Running post-action listener: _resource_record_post_action 08:38:06 INFO - ##### 08:38:06 INFO - ##### Running read-buildbot-config step. 08:38:06 INFO - ##### 08:38:06 INFO - Running pre-action listener: _resource_record_pre_action 08:38:06 INFO - Running main action method: read_buildbot_config 08:38:06 INFO - Using buildbot properties: 08:38:06 INFO - { 08:38:06 INFO - "project": "", 08:38:06 INFO - "product": "firefox", 08:38:06 INFO - "script_repo_revision": "production", 08:38:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:38:06 INFO - "repository": "", 08:38:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:38:06 INFO - "buildid": "20160302073621", 08:38:06 INFO - "pgo_build": "False", 08:38:06 INFO - "basedir": "/builds/slave/test", 08:38:06 INFO - "buildnumber": 1408, 08:38:06 INFO - "slavename": "talos-linux64-ix-050", 08:38:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:38:06 INFO - "platform": "ubuntu64_hw", 08:38:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:38:06 INFO - "branch": "fx-team", 08:38:06 INFO - "repo_path": "integration/fx-team", 08:38:06 INFO - "revision": "5bfead86cc6c7cdfe68fb584789b83c87b2c3bf2", 08:38:06 INFO - "stage_platform": "linux64", 08:38:06 INFO - "builduid": "a69e6e394cc24caabb52a0a7d196bfbd", 08:38:06 INFO - "slavebuilddir": "test" 08:38:06 INFO - } 08:38:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:38:06 INFO - Running post-action listener: _resource_record_post_action 08:38:06 INFO - ##### 08:38:06 INFO - ##### Running download-and-extract step. 08:38:06 INFO - ##### 08:38:06 INFO - Running pre-action listener: _resource_record_pre_action 08:38:06 INFO - Running main action method: download_and_extract 08:38:06 INFO - mkdir: /builds/slave/test/build/tests 08:38: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')]} 08:38:06 INFO - https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:38:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 08:38:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 08:38:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 08:38:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:38:08 INFO - Downloaded 1448 bytes. 08:38:08 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 08:38:08 INFO - Using the following test package requirements: 08:38:08 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:38:08 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:38:08 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:38:08 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:08 INFO - u'jsshell-linux-x86_64.zip'], 08:38:08 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:38:08 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:38:08 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:38:08 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:38:08 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:38:08 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:38:08 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:38:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:08 INFO - https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:38:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:38:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:38:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:38:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:38:09 INFO - Downloaded 22080961 bytes. 08:38:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:38:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:38:10 INFO - Return code: 0 08:38:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:10 INFO - https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:38:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:38:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:38:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:38:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:38:13 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip: [Errno 104] Connection reset by peer 08:38:13 INFO - retry: attempt #1 caught exception: [Errno 104] Connection reset by peer 08:38:13 INFO - retry: Failed, sleeping 30 seconds before retrying 08:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 08:38:44 INFO - Downloaded 22080961 bytes. 08:38:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:38:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:38:46 INFO - Return code: 0 08:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:46 INFO - https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:38:47 INFO - Downloaded 10808263 bytes. 08:38:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:38:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:38:47 INFO - Return code: 0 08:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:47 INFO - https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:38:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:38:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:38:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:38:48 INFO - Downloaded 54392566 bytes. 08:38:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:38:48 INFO - mkdir: /builds/slave/test/properties 08:38:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:38:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:38:48 INFO - Contents: 08:38:48 INFO - build_url:https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:38:49 INFO - Running post-action listener: _resource_record_post_action 08:38:49 INFO - Running post-action listener: set_extra_try_arguments 08:38:49 INFO - ##### 08:38:49 INFO - ##### Running populate-webroot step. 08:38:49 INFO - ##### 08:38:49 INFO - Running pre-action listener: _resource_record_pre_action 08:38:49 INFO - Running main action method: populate_webroot 08:38:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:38:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:38:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:38:49 INFO - '--tppagecycles', 08:38:49 INFO - '7'], 08:38:49 INFO - 'tests': ['tsvgm']}}, 08:38:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:38:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:38:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:38:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:38:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:38:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:38:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:49 INFO - 'talos_options': ['--e10s'], 08:38:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:49 INFO - 'tests': ['damp', 'tps']}, 08:38:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:49 INFO - 'talos_options': ['--e10s'], 08:38:49 INFO - 'tests': ['damp', 'tps']}, 08:38:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:38:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:38:49 INFO - 'other': {'tests': ['a11yr', 08:38:49 INFO - 'ts_paint', 08:38:49 INFO - 'tpaint', 08:38:49 INFO - 'sessionrestore', 08:38:49 INFO - 'sessionrestore_no_auto_restore']}, 08:38:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:38:49 INFO - 'tests': ['a11yr', 08:38:49 INFO - 'ts_paint', 08:38:49 INFO - 'tpaint', 08:38:49 INFO - 'sessionrestore', 08:38:49 INFO - 'sessionrestore_no_auto_restore']}, 08:38:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:38:49 INFO - 'tests': ['a11yr', 08:38:49 INFO - 'ts_paint', 08:38:49 INFO - 'tpaint', 08:38:49 INFO - 'sessionrestore', 08:38:49 INFO - 'sessionrestore_no_auto_restore']}, 08:38:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:38:49 INFO - 'tests': ['a11yr', 08:38:49 INFO - 'ts_paint', 08:38:49 INFO - 'tpaint', 08:38:49 INFO - 'sessionrestore', 08:38:49 INFO - 'sessionrestore_no_auto_restore']}, 08:38:49 INFO - 'other_l64': {'tests': ['a11yr', 08:38:49 INFO - 'ts_paint', 08:38:49 INFO - 'tpaint', 08:38:49 INFO - 'sessionrestore', 08:38:49 INFO - 'sessionrestore_no_auto_restore']}, 08:38:49 INFO - 'other_nol64': {'tests': ['a11yr', 08:38:49 INFO - 'ts_paint', 08:38:49 INFO - 'tpaint', 08:38:49 INFO - 'sessionrestore', 08:38:49 INFO - 'sessionrestore_no_auto_restore']}, 08:38:49 INFO - 'svgr': {'tests': ['tsvgx', 08:38:49 INFO - 'tsvgr_opacity', 08:38:49 INFO - 'tart', 08:38:49 INFO - 'tscrollx', 08:38:49 INFO - 'cart']}, 08:38:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:38:49 INFO - 'tests': ['tsvgx', 08:38:49 INFO - 'tsvgr_opacity', 08:38:49 INFO - 'tart', 08:38:49 INFO - 'tscrollx', 08:38:49 INFO - 'cart']}, 08:38:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:49 INFO - 'tests': ['tp5o']}, 08:38:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:49 INFO - 'talos_options': ['--e10s'], 08:38:49 INFO - 'tests': ['tp5o']}, 08:38:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:49 INFO - 'talos_options': ['--xperf_path', 08:38:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:49 INFO - 'tests': ['tp5n']}, 08:38:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:49 INFO - 'talos_options': ['--e10s', 08:38:49 INFO - '--xperf_path', 08:38:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:49 INFO - 'tests': ['tp5n']}}, 08:38:49 INFO - 'talos.zip': {'path': '', 08:38:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:38:49 INFO - Running post-action listener: _resource_record_post_action 08:38:49 INFO - ##### 08:38:49 INFO - ##### Running create-virtualenv step. 08:38:49 INFO - ##### 08:38:49 INFO - Running pre-action listener: _resource_record_pre_action 08:38:49 INFO - Running main action method: create_virtualenv 08:38:49 INFO - Creating virtualenv /builds/slave/test/build/venv 08:38:49 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 08:38:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:38:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:38:49 INFO - Using real prefix '/usr' 08:38:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:38:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:38:52 INFO - Installing pip.................done. 08:38:52 INFO - Return code: 0 08:38:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:52 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 0x7f386a1fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426100>, '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 0x1427000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1427490>, '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': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', '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 08:38:52 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 08:38:52 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 08:38:52 INFO - Using env: {'DISPLAY': ':0', 08:38:52 INFO - 'HOME': '/home/cltbld', 08:38:52 INFO - 'LANG': 'en_US.UTF-8', 08:38:52 INFO - 'LANGUAGE': 'en_US:en', 08:38:52 INFO - 'LOGNAME': 'cltbld', 08:38:52 INFO - 'MAIL': '/var/mail/cltbld', 08:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:52 INFO - 'MOZ_NO_REMOTE': '1', 08:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:52 INFO - 'NO_EM_RESTART': '1', 08:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:52 INFO - 'PWD': '/builds/slave/test', 08:38:52 INFO - 'SHELL': '/bin/bash', 08:38:52 INFO - 'SHLVL': '1', 08:38:52 INFO - 'TERM': 'linux', 08:38:52 INFO - 'TMOUT': '86400', 08:38:52 INFO - 'USER': 'cltbld', 08:38:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', 08:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:52 INFO - '_': '/tools/buildbot/bin/python'} 08:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:52 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 08:38:52 INFO - Cleaning up... 08:38:52 INFO - Return code: 0 08:38:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:52 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f386a1fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426100>, '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 0x1427000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1427490>, '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': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', '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 08:38:52 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>=0.7.1'] in /builds/slave/test/build 08:38:52 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>=0.7.1 08:38:52 INFO - Using env: {'DISPLAY': ':0', 08:38:52 INFO - 'HOME': '/home/cltbld', 08:38:52 INFO - 'LANG': 'en_US.UTF-8', 08:38:52 INFO - 'LANGUAGE': 'en_US:en', 08:38:52 INFO - 'LOGNAME': 'cltbld', 08:38:52 INFO - 'MAIL': '/var/mail/cltbld', 08:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:52 INFO - 'MOZ_NO_REMOTE': '1', 08:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:52 INFO - 'NO_EM_RESTART': '1', 08:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:52 INFO - 'PWD': '/builds/slave/test', 08:38:52 INFO - 'SHELL': '/bin/bash', 08:38:52 INFO - 'SHLVL': '1', 08:38:52 INFO - 'TERM': 'linux', 08:38:52 INFO - 'TMOUT': '86400', 08:38:52 INFO - 'USER': 'cltbld', 08:38:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', 08:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:52 INFO - '_': '/tools/buildbot/bin/python'} 08:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:52 INFO - Downloading/unpacking psutil>=0.7.1 08:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:54 INFO - Installing collected packages: psutil 08:38:54 INFO - Running setup.py install for psutil 08:38:54 INFO - building 'psutil._psutil_linux' extension 08:38:54 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 08:38:54 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 08:38:54 INFO - building 'psutil._psutil_posix' extension 08:38:54 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 08:38:54 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 08:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:54 INFO - Successfully installed psutil 08:38:54 INFO - Cleaning up... 08:38:54 INFO - Return code: 0 08:38:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:38: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')]} 08:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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')]} 08:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f386a1fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426100>, '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 0x1427000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1427490>, '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': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', '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 08:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:38:54 INFO - Using env: {'DISPLAY': ':0', 08:38:54 INFO - 'HOME': '/home/cltbld', 08:38:54 INFO - 'LANG': 'en_US.UTF-8', 08:38:54 INFO - 'LANGUAGE': 'en_US:en', 08:38:54 INFO - 'LOGNAME': 'cltbld', 08:38:54 INFO - 'MAIL': '/var/mail/cltbld', 08:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:54 INFO - 'MOZ_NO_REMOTE': '1', 08:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:54 INFO - 'NO_EM_RESTART': '1', 08:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:54 INFO - 'PWD': '/builds/slave/test', 08:38:54 INFO - 'SHELL': '/bin/bash', 08:38:54 INFO - 'SHLVL': '1', 08:38:54 INFO - 'TERM': 'linux', 08:38:54 INFO - 'TMOUT': '86400', 08:38:54 INFO - 'USER': 'cltbld', 08:38:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', 08:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:54 INFO - '_': '/tools/buildbot/bin/python'} 08:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:38:55 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 08:38:55 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 08:38:55 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 08:38:55 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 08:38:55 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 08:38:55 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 08:38:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:38:57 INFO - Installing collected packages: mozsystemmonitor 08:38:57 INFO - Running setup.py install for mozsystemmonitor 08:38:57 INFO - Successfully installed mozsystemmonitor 08:38:57 INFO - Cleaning up... 08:38:57 INFO - Return code: 0 08:38:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:38: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')]} 08:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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')]} 08:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:57 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 0x7f386a1fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426100>, '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 0x1427000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1427490>, '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': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', '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 08:38:57 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 08:38:57 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 08:38:57 INFO - Using env: {'DISPLAY': ':0', 08:38:57 INFO - 'HOME': '/home/cltbld', 08:38:57 INFO - 'LANG': 'en_US.UTF-8', 08:38:57 INFO - 'LANGUAGE': 'en_US:en', 08:38:57 INFO - 'LOGNAME': 'cltbld', 08:38:57 INFO - 'MAIL': '/var/mail/cltbld', 08:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:57 INFO - 'MOZ_NO_REMOTE': '1', 08:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:57 INFO - 'NO_EM_RESTART': '1', 08:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:57 INFO - 'PWD': '/builds/slave/test', 08:38:57 INFO - 'SHELL': '/bin/bash', 08:38:57 INFO - 'SHLVL': '1', 08:38:57 INFO - 'TERM': 'linux', 08:38:57 INFO - 'TMOUT': '86400', 08:38:57 INFO - 'USER': 'cltbld', 08:38:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', 08:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:57 INFO - '_': '/tools/buildbot/bin/python'} 08:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:38:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:38:59 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 08:38:59 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 08:38:59 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 08:38:59 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 08:38:59 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 08:38:59 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 08:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:38:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:38:59 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 08:38:59 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 08:38:59 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 08:38:59 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 08:38:59 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 08:38:59 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 08:38:59 INFO - Downloading docopt-0.6.1.tar.gz 08:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:00 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:00 INFO - Running setup.py install for blobuploader 08:39:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:39:00 INFO - Running setup.py install for requests 08:39:00 INFO - Running setup.py install for docopt 08:39:00 INFO - Successfully installed blobuploader requests docopt 08:39:00 INFO - Cleaning up... 08:39:00 INFO - Return code: 0 08:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:00 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 0x7f386a1fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426100>, '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 0x1427000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1427490>, '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': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', '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 08:39:00 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 08:39:00 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 08:39:00 INFO - Using env: {'DISPLAY': ':0', 08:39:00 INFO - 'HOME': '/home/cltbld', 08:39:00 INFO - 'LANG': 'en_US.UTF-8', 08:39:00 INFO - 'LANGUAGE': 'en_US:en', 08:39:00 INFO - 'LOGNAME': 'cltbld', 08:39:00 INFO - 'MAIL': '/var/mail/cltbld', 08:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:00 INFO - 'MOZ_NO_REMOTE': '1', 08:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:00 INFO - 'NO_EM_RESTART': '1', 08:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:00 INFO - 'PWD': '/builds/slave/test', 08:39:00 INFO - 'SHELL': '/bin/bash', 08:39:00 INFO - 'SHLVL': '1', 08:39:00 INFO - 'TERM': 'linux', 08:39:00 INFO - 'TMOUT': '86400', 08:39:00 INFO - 'USER': 'cltbld', 08:39:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', 08:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:00 INFO - '_': '/tools/buildbot/bin/python'} 08:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:00 INFO - Running setup.py (path:/tmp/pip-Og_mPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:00 INFO - Running setup.py (path:/tmp/pip-b6fQLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:01 INFO - Running setup.py (path:/tmp/pip-6oOSld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:01 INFO - Running setup.py (path:/tmp/pip-DmGo2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:01 INFO - Running setup.py (path:/tmp/pip-kjJvpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:01 INFO - Running setup.py (path:/tmp/pip-0E6_cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:01 INFO - Running setup.py (path:/tmp/pip-F94uVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:01 INFO - Running setup.py (path:/tmp/pip-yvq5K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:01 INFO - Running setup.py (path:/tmp/pip-brJuLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:01 INFO - Running setup.py (path:/tmp/pip-v8EkK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:01 INFO - Running setup.py (path:/tmp/pip-EVjDKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:01 INFO - Running setup.py (path:/tmp/pip-IQsoeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:01 INFO - Running setup.py (path:/tmp/pip-1_sh2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:01 INFO - Running setup.py (path:/tmp/pip-dOC9q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:01 INFO - Running setup.py (path:/tmp/pip-Wohq3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:01 INFO - Running setup.py (path:/tmp/pip-kLDpqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:02 INFO - Running setup.py (path:/tmp/pip-xsUdkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:02 INFO - Running setup.py install for manifestparser 08:39:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:39:02 INFO - Running setup.py install for mozcrash 08:39:02 INFO - Running setup.py install for mozdebug 08:39:02 INFO - Running setup.py install for mozdevice 08:39:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:39:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:39:02 INFO - Running setup.py install for mozfile 08:39:02 INFO - Running setup.py install for mozhttpd 08:39:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:39:02 INFO - Running setup.py install for mozinfo 08:39:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:39:02 INFO - Running setup.py install for mozInstall 08:39:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:39:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:39:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:39:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:39:02 INFO - Running setup.py install for mozleak 08:39:03 INFO - Running setup.py install for mozlog 08:39:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:39:03 INFO - Running setup.py install for moznetwork 08:39:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:39:03 INFO - Running setup.py install for mozprocess 08:39:03 INFO - Running setup.py install for mozprofile 08:39:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:39:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:39:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:39:03 INFO - Running setup.py install for mozrunner 08:39:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:39:03 INFO - Running setup.py install for mozscreenshot 08:39:03 INFO - Running setup.py install for moztest 08:39:03 INFO - Running setup.py install for mozversion 08:39:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:39:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:03 INFO - Cleaning up... 08:39:03 INFO - Return code: 0 08:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:03 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')]} 08:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:03 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')]} 08:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:03 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 0x7f386a1fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426100>, '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 0x1427000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1427490>, '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': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', '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 08:39:03 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 08:39:03 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 08:39:03 INFO - Using env: {'DISPLAY': ':0', 08:39:03 INFO - 'HOME': '/home/cltbld', 08:39:03 INFO - 'LANG': 'en_US.UTF-8', 08:39:03 INFO - 'LANGUAGE': 'en_US:en', 08:39:03 INFO - 'LOGNAME': 'cltbld', 08:39:03 INFO - 'MAIL': '/var/mail/cltbld', 08:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:03 INFO - 'MOZ_NO_REMOTE': '1', 08:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:03 INFO - 'NO_EM_RESTART': '1', 08:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:03 INFO - 'PWD': '/builds/slave/test', 08:39:03 INFO - 'SHELL': '/bin/bash', 08:39:03 INFO - 'SHLVL': '1', 08:39:03 INFO - 'TERM': 'linux', 08:39:03 INFO - 'TMOUT': '86400', 08:39:03 INFO - 'USER': 'cltbld', 08:39:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', 08:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:03 INFO - '_': '/tools/buildbot/bin/python'} 08:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:04 INFO - Running setup.py (path:/tmp/pip-s7Ji22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:04 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:04 INFO - Running setup.py (path:/tmp/pip-8ps5Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:04 INFO - Running setup.py (path:/tmp/pip-rsXf6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:04 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:04 INFO - Running setup.py (path:/tmp/pip-JFt83R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:04 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:04 INFO - Running setup.py (path:/tmp/pip-JysKPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:04 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:04 INFO - Running setup.py (path:/tmp/pip-x2BsHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:04 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:04 INFO - Running setup.py (path:/tmp/pip-38nocO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:04 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:04 INFO - Running setup.py (path:/tmp/pip-jsEjmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:04 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:04 INFO - Running setup.py (path:/tmp/pip-aAf8Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:04 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:04 INFO - Running setup.py (path:/tmp/pip-w1kT_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:04 INFO - Running setup.py (path:/tmp/pip-jLOUak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:04 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:04 INFO - Running setup.py (path:/tmp/pip-gEeFAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:04 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)) 08:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:05 INFO - Running setup.py (path:/tmp/pip-1lUcpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:05 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)) 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:05 INFO - Running setup.py (path:/tmp/pip-oKti66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:05 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)) 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:05 INFO - Running setup.py (path:/tmp/pip-T_4DLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:05 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)) 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:05 INFO - Running setup.py (path:/tmp/pip-qSVqGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:05 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)) 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:05 INFO - Running setup.py (path:/tmp/pip-vFRZI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:05 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)) 08:39:05 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:39:05 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:39:05 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)) 08:39:05 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)) 08:39:05 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)) 08:39:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:05 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 08:39:05 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 08:39:05 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 08:39:05 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 08:39:05 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 08:39:05 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 08:39:07 INFO - Downloading blessings-1.6.tar.gz 08:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:07 INFO - Installing collected packages: blessings 08:39:07 INFO - Running setup.py install for blessings 08:39:07 INFO - Successfully installed blessings 08:39:07 INFO - Cleaning up... 08:39:07 INFO - Return code: 0 08:39:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:39:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:07 INFO - Reading from file tmpfile_stdout 08:39:07 INFO - Current package versions: 08:39:07 INFO - argparse == 1.2.1 08:39:07 INFO - blessings == 1.6 08:39:07 INFO - blobuploader == 1.2.4 08:39:07 INFO - docopt == 0.6.1 08:39:07 INFO - manifestparser == 1.1 08:39:07 INFO - mozInstall == 1.12 08:39:07 INFO - mozcrash == 0.16 08:39:07 INFO - mozdebug == 0.1 08:39:07 INFO - mozdevice == 0.48 08:39:07 INFO - mozfile == 1.2 08:39:07 INFO - mozhttpd == 0.7 08:39:07 INFO - mozinfo == 0.9 08:39:07 INFO - mozleak == 0.1 08:39:07 INFO - mozlog == 3.1 08:39:07 INFO - moznetwork == 0.27 08:39:07 INFO - mozprocess == 0.22 08:39:07 INFO - mozprofile == 0.28 08:39:07 INFO - mozrunner == 6.11 08:39:07 INFO - mozscreenshot == 0.1 08:39:07 INFO - mozsystemmonitor == 0.0 08:39:07 INFO - moztest == 0.7 08:39:07 INFO - mozversion == 1.4 08:39:07 INFO - psutil == 3.1.1 08:39:07 INFO - requests == 1.2.3 08:39:07 INFO - wsgiref == 0.1.2 08:39:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:07 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 0x7f386a1fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426100>, '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 0x1427000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1427490>, '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': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', '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 08:39:07 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 08:39:07 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 08:39:07 INFO - Using env: {'DISPLAY': ':0', 08:39:07 INFO - 'HOME': '/home/cltbld', 08:39:07 INFO - 'LANG': 'en_US.UTF-8', 08:39:07 INFO - 'LANGUAGE': 'en_US:en', 08:39:07 INFO - 'LOGNAME': 'cltbld', 08:39:07 INFO - 'MAIL': '/var/mail/cltbld', 08:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:07 INFO - 'MOZ_NO_REMOTE': '1', 08:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:07 INFO - 'NO_EM_RESTART': '1', 08:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:07 INFO - 'PWD': '/builds/slave/test', 08:39:07 INFO - 'SHELL': '/bin/bash', 08:39:07 INFO - 'SHLVL': '1', 08:39:07 INFO - 'TERM': 'linux', 08:39:07 INFO - 'TMOUT': '86400', 08:39:07 INFO - 'USER': 'cltbld', 08:39:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', 08:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:07 INFO - '_': '/tools/buildbot/bin/python'} 08:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 INFO - Cleaning up... 08:39:07 INFO - Return code: 0 08:39:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f386a1fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426100>, '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 0x1427000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1427490>, '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': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', '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 08:39: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', 'jsonschema'] in /builds/slave/test/build 08:39: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 jsonschema 08:39:07 INFO - Using env: {'DISPLAY': ':0', 08:39:07 INFO - 'HOME': '/home/cltbld', 08:39:07 INFO - 'LANG': 'en_US.UTF-8', 08:39:07 INFO - 'LANGUAGE': 'en_US:en', 08:39:07 INFO - 'LOGNAME': 'cltbld', 08:39:07 INFO - 'MAIL': '/var/mail/cltbld', 08:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:07 INFO - 'MOZ_NO_REMOTE': '1', 08:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:07 INFO - 'NO_EM_RESTART': '1', 08:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:07 INFO - 'PWD': '/builds/slave/test', 08:39:07 INFO - 'SHELL': '/bin/bash', 08:39:07 INFO - 'SHLVL': '1', 08:39:07 INFO - 'TERM': 'linux', 08:39:07 INFO - 'TMOUT': '86400', 08:39:07 INFO - 'USER': 'cltbld', 08:39:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', 08:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:07 INFO - '_': '/tools/buildbot/bin/python'} 08:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:08 INFO - Downloading/unpacking jsonschema 08:39:08 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 08:39:08 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 08:39:08 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 08:39:08 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 08:39:08 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 08:39:08 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 08:39:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:09 INFO - Downloading/unpacking functools32 (from jsonschema) 08:39:09 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 08:39:09 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 08:39:09 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 08:39:09 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 08:39:09 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 08:39:09 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 08:39:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:10 INFO - warning: no files found matching '*.txt' 08:39:10 INFO - no previously-included directories found matching 'build' 08:39:10 INFO - no previously-included directories found matching 'dist' 08:39:10 INFO - no previously-included directories found matching '.git*' 08:39:10 INFO - Installing collected packages: jsonschema, functools32 08:39:10 INFO - Running setup.py install for functools32 08:39:10 INFO - warning: no files found matching '*.txt' 08:39:10 INFO - no previously-included directories found matching 'build' 08:39:10 INFO - no previously-included directories found matching 'dist' 08:39:10 INFO - no previously-included directories found matching '.git*' 08:39:10 INFO - Successfully installed jsonschema functools32 08:39:10 INFO - Cleaning up... 08:39:10 INFO - Return code: 0 08:39:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f386a1fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13973b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426100>, '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 0x1427000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1427490>, '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': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', '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 08:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:39:10 INFO - Using env: {'DISPLAY': ':0', 08:39:10 INFO - 'HOME': '/home/cltbld', 08:39:10 INFO - 'LANG': 'en_US.UTF-8', 08:39:10 INFO - 'LANGUAGE': 'en_US:en', 08:39:10 INFO - 'LOGNAME': 'cltbld', 08:39:10 INFO - 'MAIL': '/var/mail/cltbld', 08:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:10 INFO - 'MOZ_NO_REMOTE': '1', 08:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:10 INFO - 'NO_EM_RESTART': '1', 08:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:10 INFO - 'PWD': '/builds/slave/test', 08:39:10 INFO - 'SHELL': '/bin/bash', 08:39:10 INFO - 'SHLVL': '1', 08:39:10 INFO - 'TERM': 'linux', 08:39:10 INFO - 'TMOUT': '86400', 08:39:10 INFO - 'USER': 'cltbld', 08:39:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', 08:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:10 INFO - '_': '/tools/buildbot/bin/python'} 08:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:10 INFO - Downloading/unpacking flake8 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:39:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:39:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:39:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:39:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:39:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:39:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:39:13 INFO - no previously-included directories found matching 'docs/_build' 08:39:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:39:13 INFO - Running setup.py install for pep8 08:39:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:39:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:39:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:39:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:39:13 INFO - no previously-included directories found matching 'docs/_build' 08:39:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:39:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:39:13 INFO - Cleaning up... 08:39:13 INFO - Return code: 0 08:39:13 INFO - Running post-action listener: _resource_record_post_action 08:39:13 INFO - Running post-action listener: _start_resource_monitoring 08:39:13 INFO - Starting resource monitoring. 08:39:13 INFO - ##### 08:39:13 INFO - ##### Running install step. 08:39:13 INFO - ##### 08:39:13 INFO - Running pre-action listener: _resource_record_pre_action 08:39:13 INFO - Running main action method: install 08:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:13 INFO - Reading from file tmpfile_stdout 08:39:13 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:39:13 INFO - Reading from file tmpfile_stdout 08:39:13 INFO - Output received: 08:39:13 INFO - Usage: mozinstall [options] installer 08:39:13 INFO - Options: 08:39:13 INFO - -h, --help show this help message and exit 08:39:13 INFO - -d DEST, --destination=DEST 08:39:13 INFO - Directory to install application into. [default: 08:39:13 INFO - "/builds/slave/test"] 08:39:13 INFO - --app=APP Application being installed. [default: firefox] 08:39:13 INFO - mkdir: /builds/slave/test/build/application 08:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:39:29 INFO - Reading from file tmpfile_stdout 08:39:29 INFO - Output received: 08:39:29 INFO - /builds/slave/test/build/application/firefox/firefox 08:39:29 INFO - Running post-action listener: _resource_record_post_action 08:39:29 INFO - ##### 08:39:29 INFO - ##### Running run-tests step. 08:39:29 INFO - ##### 08:39:29 INFO - Running pre-action listener: _resource_record_pre_action 08:39:29 INFO - Running main action method: run_tests 08:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:39:29 INFO - Python 2.7.3 08:39:29 INFO - Return code: 0 08:39:29 INFO - grabbing minidump binary from tooltool 08:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:29 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1426100>, '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 0x1427000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1427490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:39:29 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 08:39:29 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 08:39:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:39:29 INFO - Return code: 0 08:39:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:39:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:39:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:39:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:39:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:39:30 INFO - Return code: 0 08:39:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:39:30 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:39:30 INFO - Using env: {'DISPLAY': ':0', 08:39:30 INFO - 'HOME': '/home/cltbld', 08:39:30 INFO - 'LANG': 'en_US.UTF-8', 08:39:30 INFO - 'LANGUAGE': 'en_US:en', 08:39:30 INFO - 'LOGNAME': 'cltbld', 08:39:30 INFO - 'MAIL': '/var/mail/cltbld', 08:39:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:30 INFO - 'MOZ_NO_REMOTE': '1', 08:39:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:30 INFO - 'NO_EM_RESTART': '1', 08:39:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:30 INFO - 'PWD': '/builds/slave/test', 08:39:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:30 INFO - 'SHELL': '/bin/bash', 08:39:30 INFO - 'SHLVL': '1', 08:39:30 INFO - 'TERM': 'linux', 08:39:30 INFO - 'TMOUT': '86400', 08:39:30 INFO - 'USER': 'cltbld', 08:39:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246', 08:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:30 INFO - '_': '/tools/buildbot/bin/python'} 08:39:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:39:30 INFO - mozversion application_buildid: 20160302073621 08:39:30 INFO - mozversion application_changeset: 5bfead86cc6c7cdfe68fb584789b83c87b2c3bf2 08:39:30 INFO - mozversion application_display_name: Nightly 08:39:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:39:30 INFO - mozversion application_name: Firefox 08:39:30 INFO - mozversion application_remotingname: firefox 08:39:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:39:30 INFO - mozversion application_vendor: Mozilla 08:39:30 INFO - mozversion application_version: 47.0a1 08:39:30 INFO - mozversion platform_buildid: 20160302073621 08:39:30 INFO - mozversion platform_changeset: 5bfead86cc6c7cdfe68fb584789b83c87b2c3bf2 08:39:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:39:30 INFO - mozversion platform_version: 47.0a1 08:39:30 INFO - using testdate: 1456936770 08:39:30 INFO - actual date: 1456936770 08:39:30 INFO - starting webserver on 'localhost:51823' 08:39:30 INFO - SUITE-START | Running 2 tests 08:39:30 INFO - TEST-START | dromaeo_css 08:39:30 INFO - operating with platform_type : linux_ 08:39:30 INFO - Initialising browser for dromaeo_css test... 08:39:30 INFO - TEST-INFO | started process 16058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdu4uEM/profile http://localhost:51823/getInfo.html) 08:39:35 INFO - PROCESS | 16058 | __metrics Screen width/height:1600/1200 08:39:35 INFO - PROCESS | 16058 | colorDepth:24 08:39:35 INFO - PROCESS | 16058 | Browser inner width/height: 1024/697 08:39:35 INFO - PROCESS | 16058 | __metrics 08:39:35 INFO - PROCESS | 16058 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:36 INFO - TEST-INFO | 16058: exit 0 08:39:36 INFO - Browser initialized. 08:39:36 INFO - Running cycle 1/1 for dromaeo_css test... 08:39:36 INFO - TEST-INFO | started process 16153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdu4uEM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:48 INFO - PROCESS | 16153 | RSS: Main: 155201536 08:39:48 INFO - PROCESS | 16153 | 08:40:40 INFO - PROCESS | 16153 | 1456936840076 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] 08:42:51 INFO - PROCESS | 16153 | Cycle 1(1): loaded http://localhost:51823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51823/tests/dromaeo/cssquery-ext.html) 08:42:52 INFO - PROCESS | 16153 | RSS: Main: 243609600 08:42:52 INFO - PROCESS | 16153 | 08:45:54 INFO - PROCESS | 16153 | Cycle 1(1): loaded http://localhost:51823/tests/dromaeo/cssquery-ext.html (next: http://localhost:51823/tests/dromaeo/cssquery-jquery.html) 08:45:55 INFO - PROCESS | 16153 | RSS: Main: 243097600 08:45:55 INFO - PROCESS | 16153 | 08:48:57 INFO - PROCESS | 16153 | Cycle 1(1): loaded http://localhost:51823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51823/tests/dromaeo/cssquery-mootools.html) 08:48:57 INFO - PROCESS | 16153 | RSS: Main: 235716608 08:48:57 INFO - PROCESS | 16153 | 08:51:59 INFO - PROCESS | 16153 | Cycle 1(1): loaded http://localhost:51823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51823/tests/dromaeo/cssquery-prototype.html) 08:52:00 INFO - PROCESS | 16153 | RSS: Main: 219738112 08:52:00 INFO - PROCESS | 16153 | 08:55:02 INFO - PROCESS | 16153 | Cycle 1(1): loaded http://localhost:51823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51823/tests/dromaeo/cssquery-yui.html) 08:55:03 INFO - PROCESS | 16153 | RSS: Main: 198934528 08:55:03 INFO - PROCESS | 16153 | 08:58:06 INFO - PROCESS | 16153 | Cycle 1(1): loaded http://localhost:51823/tests/dromaeo/cssquery-yui.html (next: http://localhost:51823/tests/dromaeo/cssquery-dojo.html) 08:58:06 INFO - PROCESS | 16153 | RSS: Main: 269787136 08:58:06 INFO - PROCESS | 16153 | 08:58:06 INFO - PROCESS | 16153 | __start_tp_report 08:58:06 INFO - PROCESS | 16153 | _x_x_mozilla_page_load 08:58:06 INFO - PROCESS | 16153 | _x_x_mozilla_page_load_details 08:58:06 INFO - PROCESS | 16153 | |i|pagename|runs| 08:58:06 INFO - PROCESS | 16153 | |0;dojo.html;2588.8964441422345;2664.7868170546344;2679.2765953192625;2684.3960108975484;2709.6477457930464;4402.075564131536;4494.348319493672;4550.203714349988;4554.066416384641;4561.635069194464;4569.246074397721;4575.611073058794;4614.723116613006;4625.213713668676;4674.766261686919;4138.089620283533;4156.189543039109;4223.957760422395;4269.573042695721;4271.103068355649;4227.704060715751;4288.892777680552;4294.312909934395;4295.548967358429;4318.762468064255;4061.147159096608;4158.812853421603;4219.092895027553;4270.14597080582;4278.251306021434;4165.770882601456;4177.352510360899;4181.665466762652;4212.515560710527;4227.32362821947;4015.3976903464713;4156.688248381353;4165;4187.602177793105;4225.091605304874;4415.8233670653135;4416.779161041935;4479.484859241196;4493.191225579394;4520.367148599199;4800.303955926406;4807.831725889612;4811.398575178103;4814.494478079821;4832.1543729847135;4670.859874203779;4823.372961515016;4841.830535931261;4847.369841920563;4895.755212239409;4555.794989225493;4559.361689363492;4565.315202719618;4565.657575681771;4603.5856772890265;4955.207166853286;4996.475370086088;5005.299258103868;5050.292958985745;5056.797728090909;4617.191991401492;4789.161896668069;4793;4820.783064762094;4885.97394547142;4848.660593758474;4861.197902346144;4867.123917694849;4899.240617704261;4913.557779799835;4806.303086052572;4808.591269742041;4812.687175333662;4812.879678008007;4860.538248866352;4614.7461889595725;4752.7623618818925;4811.158047341702;4840.370751802243;4841.661083724105;4029.5366032906004;4041.535223449341;4049.149678567534;4055.411965265079;4073.9388909166387;3587.2287458196092;3587.2466781976077;3598.0105470995163;3598.082488965297;3622.130688634709;4090.81591328385;4188.769617670996;4190.748555086705;4286.249906266453;4289.849855255051;4873.439554451213;4895.853124406273;4901;4901.607871370282;4930.605551555867;4237.449131612871;4255.255330317182;4256.59562341577;4257.063446041866;4281.272183728774;4179.853705120367;4263.211305908417;4313.6980411370905;4315.503717072514;4345.847895323648;4599.379083823641;4610.608098311681;4611.723296602215;4612.169809434334;4659.20793465105;4656.068786242698;4803;4820.758962051954;4822.855314340575;4865.781039853145;4572.908541829212;4709.081729062937;4720.740359280273;4726.550977657117;4755.952440475689;4771.618270538418;4773.9761301193275;4783.497732738012;4789.473157952552;4807.543283388072;4661.976690116663;4835.081334546425;4846.903061938812;4889.168841297059;4906.509349065065;4675.742834144019;4679.2045352289515;4684.391029166187;4689.835855745033;4724.173269677862;4661.230896902109;4684.789184486638;4690.460597031385;4743.027679325661;4748.691335063348;4481.529439408815;4616.076784643018;4627.1439783640135;4659.4175728034;4756.167670657552;4751.097291514601;4760.143174228672;4770.236762118045;4798.088363210979;4822;4670.1126785910565;4674.368960190467;4676.906461870812;4699.882502937454;4722.079194557028 08:58:06 INFO - PROCESS | 16153 | |1;ext.html;486.60341821415545;488.81425058477794;492.69452939177717;506.36956988549264;519.5765451157306;26746.197614071585;33430;33451.49822752661;33607.15982100449;33646.15884602883;36332.81833590828;36728.674342220365;36921.44617830728;36936.81531592345;36986.26027479449;7670.079590449154;7868;7869.134395216522;7869.921300786976;7872.5670088145125;7826.060872695256;7977.601119944009;7993.08079570851;7998.800029999267;8006.479578827358;7920.881186782203;7979.720709775159;8000.919990800105;8001.559914204717;8008.398320335927;7924.960375198145;7991.440599158062;8006.599670016476;8015.7194498192575;8017.719379821737;7800.375969922393;7866.488678235896;7931.087924888654;7940.0868900076075;7943.285104340579;36558.45162322541;37347.62652373469;37353.81323093394;37360.25279494422;37378.81310593457;2879.3233590106306;3035.8178509289514;3304.5043243513423;3632.9273414531826;3713.9814300928324;26466.86766566155;26517.867410663017;26847.194584162506;27793.722062779314;27823;3036.3016506203476;3081.168084617163;3113.3306339137193;3117.485614873543;3134.49848024315;222130;224836;225989;227727;227740;39313.41029884554;57014.42985570174;57910;57962.13056804067;58042.419575804546;39212.6078739209;39733.60266397357;39837;39857.80071099626;39859.800700996886;11266.493007814668;11542.59600913964;11550.826737598944;11553.595624153115;11558.826617600742;8165.959170204111;8179.345652347798;8203.466774659628;8213.178682131738;8275.875861862078;13823.79264311036;13830.446782128602;13838.446462141603;13844.377003034888;13879.861201387857;5538.154115149245;5758.193852860602;5767.711614419262;5798.159266906359;5828.009238429478;820.5815034332534;882.9161229683169;903.1781079217881;938.0994245524373;1055.4247934875511;25511.617325740128;26267.737322626912;26586.069487567842;26926.865365673046;26957.865210673823;925.379995403068;941.3928016429502;947.4978261521404;1001.9248556358302;1043.7703705185;13145.934270328778;13269.982176281155;13332;13400.664983375493;13410.932945335211;329393;331392;333101;334752;335130;45725.54274457279;46242.76878615585;46246.306305405444;46455.76772116118;46493.07013859704;1188.1385995153616;1189.9825649070094;1199.0347770045198;1199.5441732141906;1320.1551007355301;24138.637920430858;27917.441651167268;29450.558241626823;30066.549001764553;31936.840315799203;44262.778686106365;44830;44915.55084449114;44984.550154498036;44993.32510012287;200232;201569;201990;202243;202375;30367;39008.609913900495;39477.40783888187;39870.80064599658;40433;36526.26947461089;36769.63230367662;36847.815760922094;37205.44191837071;37217.4417383734;31176;31194.376112478076;31525.36949260956;31527.527087093255;32043;31171.220719482193;31254.374912501167;31273.8436307817;31504.2123946894;31696.36607267888;31662.208444789063;31893.8405307972;31913.202169945936;33536;34379.656203438644;29763.255918602208;30286.394272114874;30395.848020759753;30437;30488.237794055327;23776.88111559431;23820.404489887198;23848.88075559611;23971.640425393285;24001.879990599937 08:58:06 INFO - PROCESS | 16153 | |2;jquery.html;313.7192212969392;315.7316281161013;318.29338867713665;324.54077480365254;334.81752444917504;14112.858871411283;15037.172955487444;15527.611809704735;15550.377984880606;15586.376544938203;13748.518801841938;14194.36125374358;14596.416143354252;14773.92613036936;14877.107373557594;4325.2647050001415;4446.688731788776;4458.97770511147;4466.553344665524;4471.731696098244;4409.272470042455;4446.133004064209;4448.110377924412;4643.210654188796;4924.384451943507;4720.575148236658;4851.539103785135;4862.683925544846;4880.316755654194;4886;4939.555440010398;4940.209566469348;4955.4548999610015;4962.156433406293;4962.45413004571;4649.232876575395;4836.733979631119;4869.5130486951375;4874.147024270738;4882.853514394538;11009.064229540418;11225.607103751412;11234.719132021683;11261.943690281578;17410.825891741046;1947.3963071447754;2041.6427125253022;2044.9079791409422;2065.3390914907236;2422.140140250221;8069.596520173968;8460.280876125536;8654.177853103945;8690.652373905099;8812.735617931472;1651.405494022163;1702.608400067979;1731.9480415587427;1792.9641407171914;1831.6886129357908;51903;52651;53390.19914701283;55959.16061259125;57776;9081.091890810998;9099.408538444979;9430.10414010668;9465;9992.500374981222;12314.322712250732;12352.197107188184;12486.875131248571;12498.625041248777;12520.186187897758;6265.216847894013;6460.806175814733;6464.547481676237;6477.546571739933;6525.053867189231;5942.346341902387;6119.051547010221;6125.387461253839;6150.846228844314;6291.748330066746;4045.3931910213705;4069.2268468990796;4078.530968938551;4086.3870419436726;4105.794710264475;1682.8906121102088;1723.276223985929;1734.6270551831417;1734.8612111031086;1754.859341428082;370.25948103792416;719.7301012120455;788.8777239527882;890.247740659142;909.3907082254905;9323;9617.663381781744;9927.80144397108;10156.4921753912;10250.128739057263;381.45261549676303;399.4308110941896;401.37185304998167;402.53306164848635;416.3151615592394;5265.473452654704;5304.628675992643;5351.25082488452;5363.168708850135;5404.216388623706;388511;389324;390022;397272;397759;48153;51963.740181298854;58929.70535147297;67397;69015.65492172507;382.2107348325754;414.4136047492824;416.0949933893829;416.37959440433536;416.4232537934921;9122.908770912207;9158.633654653739;9337.299702522203;9596.76008099803;9612.471314077793;31334.05997820069;32027.83986080055;32195;32360.352792943537;32463.837680811444;41420.378694319006;42973.785131074146;43923.78038109789;44056.11887762163;44705.55294447144;7001.124859392576;7016.859662806817;7157.892631610634;7209.531380460253;7214.098237720285;9323.860142097737;11079.390633515233;11199.440027998731;11317.886821132013;11326.83009754871;9189.908100918905;9260.351775375659;9326.300527460331;9577;9740.12338889475;5370.892582148414;8115.959420202861;9339;9762.511874406393;9848.556814943202;9680.709578712649;9699.127078562964;10041.347312424668;10136.645217417356;10342.638007669695;6916.170059592881;7050.506464547432;7082.4688148390105;7143.607101609461;7158.46311526648;7373.33639972405;10020.24848136378;10104.545295461576;10192;10291.279610427198 08:58:06 INFO - PROCESS | 16153 | |3;mootools.html;1219.5609580550995;1347.8382594088707;1354.6274774437024;1461.9780703289453;1727.0673836128492;7011.684474198661;7129.85740285194;7156.928430715704;7173.892391614117;7193.640317984099;6990.5456145350645;7158.785236442902;7162.462815288861;7162.820929476766;7173.139223293199;1661.6261341198256;1984.7122167285736;2030.8781473111624;2037.908294126768;2063.3912995666237;1993.4717299915535;2000.9299674511394;2002.499375156211;2003.459066052165;2003.8597298189134;1944.8833070015774;1961.0292905012038;2001.629698505781;2002.3492364981366;2003.9398818035481;1978.980210197894;2006.1674405121857;2010.7888671689482;2014.4762361785968;2027.787082356346;1989.7910719374402;1996.4110587376758;1996.6805311150292;2000.1799262302532;2001.2295266322426;7300.926990730078;7335.5231909926215;7340.559566426032;7348.559086454777;7355.301246381585;3908.062065104383;3978.661813745835;3996.100877302613;3997.6601988830985;3999.9400008999887;2518.7859031982302;2680.2227354067295;2688.90588829392;2697.298702337406;2699.595060740885;826.1531929771971;859.5616235719765;875.1379890807549;875.4353442029856;880.9295256379474;9774.75563110928;9844.753881153028;9853.753656158653;9866.210703143803;9898.158656514204;3554.2891421715244;3669.192777588926;3719.479272901796;3741.9438708419398;3765.7175711821724;8442.07137214906;8524.318054555744;8529.701460448854;8537.615807288686;8554.35842311829;3536.45184996326;4091.365838295069;4105.34314509677;4111.691623128278;4117.670586353084;3637.454381842692;3699.667029967316;3704;3709.9443508347395;3712.6287371263197;3108.8290144041844;3206.4228438881223;3212.1327241644626;3221.7261532769508;3223.5164725291393;970.2044323654677;985.4136788610765;985.5023213277392;990.6582229130938;998.8152191844532;1044.013298268254;1109.8890110988998;1114.3091283404342;1174.723939874129;1182.1252273317682;6853.965730171317;6866.725330986705;6902.5858448492245;6943.132108486439;6991.860162796817;424.63057140288146;433.0624198609974;434.71960585422227;434.8847555397822;435.16448419035527;5011.298418221452;5026.346574945233;5029.471905449948;5029.547340739351;5043.193089105799;8693.869591956125;8751.299896008431;8893.955530222307;8973.461592304482;8977.281817454588;8757.386982911135;8873.112688731204;8891.555422228863;8892.510911899908;8901.421407608614;6564.27372291949;6677.165354330708;6756.155480564929;6765.560238584476;6800.727970881208;6531.412172904462;6669.0329902164885;6671.83320416974;6672.165979252593;6672.899906501503;7691.923080769345;7867.803304917423;7931.60341982887;8071.112177660335;8115.310198632947;8041.959790201246;8184.386171037077;8252.504849708797;8332.541710205996;8364.289035432057;5240.423553409199;6024.9397506026135;6294.0558916162945;6331.651759153291;6333.050042493663;6624.668766561749;6673.699683514351;6679.198496180489;6684.699188536625;6698.363655452724;5989.371116032754;6069.969650151721;6089.634621922699;6141.631502109888;6172.475339596184;5926.259217597801;5963.135345374983;6041.667708276087;6108.633481991094;6113.908291375722;6485.870282594227;6573.835654108494;6581.144451221502;6582.80251592453;6588.769393071219;5940.673262970578;5942.851428714317;5948.10778383246;5965.582409231486;5976.581639285208;5873.73568189424;6038.882806680603;6039.78860739872;6052.515798736179;6127.632342059313 08:58:06 INFO - PROCESS | 16153 | |4;prototype.html;285.1530953069384;287.9424115176965;288.8786709581975;292.472087881374;295.7855554722825;5223.817166399177;5231.293775340333;5237.895242095161;5257.237700533425;5307.52232299093;4964.950350496494;5142.7428628568605;5176.58587313015;5208.7395630218525;5215.713135777531;3796.2027974125467;3879.2047630235734;3968.16668499614;3973.6821054315656;3978.9403158952637;4002.3196056670436;4015.4980627421573;4015.9397609035886;4021.235965166624;4024.9597504024878;3971.305021621219;3975.761454312736;3982.4822773039464;3987.4816273884353;3990.501187351581;3754.887353379403;3850.4994350734505;3957.465742124834;3976.2445135424177;3981.024648961023;3442.4492081266876;3447.3622379859808;3449.6550344965553;3451.913702157466;3461.671141241578;5019.121653710586;5030.220315851049;5030.2957585938;5033.043721692903;5041.823536176216;4557.248054071074;4564.087182563468;4565.977170114162;4570.611498022672;4571.131485017836;5452.672839629635;5459.69971651559;5460.590455715837;5466.371367292772;5471.343438787331;3763.9247215055548;3764.416515440111;3768.1521657626813;3769.379166958207;3771.264603402338;5561.193626924073;5693.971530142364;5769.105788602773;5790.623609465413;5795.420457954171;3810.3522401191863;3819.904502387407;3835.4438606401914;3839.9424008639894;3840.7503512271614;3887.9805600971813;3888.16404473034;3891.3579259422445;3893.922121557553;3894.6494815466745;4509.887252818706;4512.548745125461;4514.390557274726;4520.434945631796;4520.706154099973;5461.0716178249795;5474.562035037187;5485;5490.313710786152;5493.066178749622;1346.912450690702;1368.9657758556116;1369.8767110960061;1371.5542448704011;1374.6838227207797;861.6381119929645;882.1972005475116;909.1090731083575;929.8558723397884;930.186087173723;4803.447603525569;4826.276058591239;4843.4430040545085;4858.58702010326;4861.854144375674;5664.433556644385;5665.235193248941;5666.801661941812;5668.659880407106;5679.574031947538;4803.927941080817;4842.249451335048;4842.297866809293;4844.660873738804;4848.9757551212015;3008.3832814273023;3046.131852422049;3046.466868298039;3046.6800985896607;3048.8628011739524;5367.436419176009;5369.19462080691;5373.247745315659;5382.596305277119;5385.272988146628;5604.60767746262;5736.827895163152;5789.797357092481;5791.710414479344;5802.361740208658;5349.919751203735;5360.544353729977;5372.785088596413;5379.811706590329;5386.326709161355;5631.746571404378;5633.605647604629;5638.097904335286;5641;5645.887082258414;5438.809641662523;5493.121100623881;5500.367457742411;5501.834944951498;5509.47659972302;5373.35519737634;5382.811601593926;5386.542143917811;5388.676679399248;5391.32608423947;3685.852565897334;3832.4251362295877;3835.1562656215588;3839.8080095995647;3849.441830934443;5656.886862262814;5675.489205971482;5693.202951586864;5693.4021927696995;5695.857603559944;5492.780288788404;5494.1758736189895;5496.587755918402;5504.669719816824;5506.1190209566275;5483.2049352844415;5486.615936884539;5487.396386397573;5494.835154945358;5503.3120859892515;5388.110961691277;5390.05674007055;5397.892042159214;5405.5135037846785;5406.2701535292235;5383.219433182245;5504.422035686195;5526.447355264441;5537.169424586184;5539.446055394428;5378.515933565998;5406.810761623325;5407.972485227794;5412.83761487156;5418.512333889968 08:58:06 INFO - PROCESS | 16153 | |5;yui.html;558.941311162328;588.0767195503059;646.6411141816291;696.9198542167649;700.1737949219919;10883.510242039107;12552.937235313822;12787.552435664753;12792.616221513346;12851.678708032305;12662;12696;12716.173448725849;12749.617511474647;12775.808362874564;594.0969726016442;606.0454783715644;606.6572386601578;607.9878402431949;756.9016027916363;763.2787016269627;769.3037800790294;771.1709911844762;774.4965772248028;776.0415886380316;800.6997375984006;806.4395245304515;806.5644551941973;811.8701007838747;812.7683610171102;620.0667994668019;788.3102285500187;796.9641366138537;798.6765360029198;805.6696754330726;584.8947189505888;584.9181114643953;585.0843430031987;589.7287247865987;589.8849724303763;11304.886951130466;11779.7055073623;11804.822927656092;11806.940965295204;11807.29156250619;10896.78206435867;11080.501377438035;11210.551577936872;11309.208355415125;11594.6521604352;9249.121333473377;9438.103380178873;9567.282453815922;9689.612415503441;9728.221742260603;2910.286979689968;2926.941461170786;2928.209383466452;3042.2698552347497;3047.9238019049703;40696;41228;41374;41447.792761036304;41457.378139327935;8978.416402933788;9025.41334813235;9115;9151.222146117521;9180.219681327162;15662.216889155497;15717.842821571638;15752.842471575137;15753.763693544606;15889.682206355808;5965.910511342333;5989.341172471025;6002.129691194839;6195.473384762346;6334.461570766444;3559.394902866519;3633.8728144514816;3724.5530536335814;3730.2166545025307;3738.3084129435597;2524.835885667426;2553.1957433408415;2555.514452254103;2555.9361015974378;2559.436923876744;410.2226281197115;461.22053729197546;464.53314419009354;474.9382580264544;476.790212306584;585.4438283630568;595.2083728640897;595.5860676829562;596.6718304932269;606.7876243314804;7380.704771809175;7590.203028682019;7803.882941755878;7848.607569621496;7867.921320786833;564.6358099026105;572.8485743655283;574.5174053794832;585.3122580967431;590.2297501760158;3430.9142271442915;3515.5781306243416;3545.7163426925786;3614.512040874501;3734.607866174067;45103;45280.77359613181;46282.30576541355;47309.76345118252;48308.7584562082;41614.791926040176;41629.583704163175;42009.369859452134;42202;42549.78725106417;38117.428238576445;38759.806200968815;39490.605093948696;39744.60255397467;40001.39997900092;6995.580265184105;7219;7599.810004749926;7685.385169186564;7859.214078592095;29948.401031978803;30498.84750576233;30550.541741874335;31150.37699245957;31427;33101.33797323992;33821.49267760936;37055.258894822495;37295.64339209484;37675.2464950694;8542.78643033929;8618.396712230335;8658.783530411538;10386.636467723594;10389.37663740178;10991.285566438157;11036.425197007566;11237.719057023312;11275;11321.150913681342;10110.69667909964;10383.636572719919;10436.321639093434;10751;11239.213255072067;9987.900120998696;10196.133328667147;10249.436281004617;10585.047345738612;10757.9462102689;10297.279190456597;10316.226283028953;10371.58513659445;10616.575336986434;10633.415162166155;8638;8850.73447796567;9083.478694243708;9104.863427048467;9263.16631503168;8609.569521524025;8677;8892.59983300766;9053;9086.591103400231 08:58:06 INFO - PROCESS | 16153 | __end_tp_report 08:58:06 INFO - PROCESS | 16153 | __start_cc_report 08:58:06 INFO - PROCESS | 16153 | _x_x_mozilla_cycle_collect,845 08:58:06 INFO - PROCESS | 16153 | __end_cc_report 08:58:06 INFO - PROCESS | 16153 | __startTimestamp1456937886420__endTimestamp 08:58:06 INFO - PROCESS | 16153 | 08:58:06 INFO - PROCESS | 16153 | ------- Summary: start ------- 08:58:06 INFO - PROCESS | 16153 | Number of tests: 6 08:58:06 INFO - PROCESS | 16153 | 08:58:06 INFO - PROCESS | 16153 | [#0] dojo.html Cycles:165 Average:4493.05 Median:4625.21 stddev:450.91 (9.7%) stddev-sans-first:426.83 08:58:06 INFO - PROCESS | 16153 | Values: 2588.9 2664.8 2679.3 2684.4 2709.6 4402.1 4494.3 4550.2 4554.1 4561.6 4569.2 4575.6 4614.7 4625.2 4674.8 4138.1 4156.2 4224.0 4269.6 4271.1 4227.7 4288.9 4294.3 4295.5 4318.8 4061.1 4158.8 4219.1 4270.1 4278.3 4165.8 4177.4 4181.7 4212.5 4227.3 4015.4 4156.7 4165.0 4187.6 4225.1 4415.8 4416.8 4479.5 4493.2 4520.4 4800.3 4807.8 4811.4 4814.5 4832.2 4670.9 4823.4 4841.8 4847.4 4895.8 4555.8 4559.4 4565.3 4565.7 4603.6 4955.2 4996.5 5005.3 5050.3 5056.8 4617.2 4789.2 4793.0 4820.8 4886.0 4848.7 4861.2 4867.1 4899.2 4913.6 4806.3 4808.6 4812.7 4812.9 4860.5 4614.7 4752.8 4811.2 4840.4 4841.7 4029.5 4041.5 4049.1 4055.4 4073.9 3587.2 3587.2 3598.0 3598.1 3622.1 4090.8 4188.8 4190.7 4286.2 4289.8 4873.4 4895.9 4901.0 4901.6 4930.6 4237.4 4255.3 4256.6 4257.1 4281.3 4179.9 4263.2 4313.7 4315.5 4345.8 4599.4 4610.6 4611.7 4612.2 4659.2 4656.1 4803.0 4820.8 4822.9 4865.8 4572.9 4709.1 4720.7 4726.6 4756.0 4771.6 4774.0 4783.5 4789.5 4807.5 4662.0 4835.1 4846.9 4889.2 4906.5 4675.7 4679.2 4684.4 4689.8 4724.2 4661.2 4684.8 4690.5 4743.0 4748.7 4481.5 4616.1 4627.1 4659.4 4756.2 4751.1 4760.1 4770.2 4798.1 4822.0 4670.1 4674.4 4676.9 4699.9 4722.1 08:58:06 INFO - PROCESS | 16153 | 08:58:06 INFO - PROCESS | 16153 | [#1] ext.html Cycles:180 Average:40556.28 Median:34012.91 stddev:68125.67 (200.3%) stddev-sans-first:68250.35 08:58:06 INFO - PROCESS | 16153 | Values: 486.6 488.8 492.7 506.4 519.6 26746.2 33430.0 33451.5 33607.2 33646.2 36332.8 36728.7 36921.4 36936.8 36986.3 7670.1 7868.0 7869.1 7869.9 7872.6 7826.1 7977.6 7993.1 7998.8 8006.5 7920.9 7979.7 8000.9 8001.6 8008.4 7925.0 7991.4 8006.6 8015.7 8017.7 7800.4 7866.5 7931.1 7940.1 7943.3 36558.5 37347.6 37353.8 37360.3 37378.8 2879.3 3035.8 3304.5 3632.9 3714.0 26466.9 26517.9 26847.2 27793.7 27823.0 3036.3 3081.2 3113.3 3117.5 3134.5 222130.0 224836.0 225989.0 227727.0 227740.0 39313.4 57014.4 57910.0 57962.1 58042.4 39212.6 39733.6 39837.0 39857.8 39859.8 11266.5 11542.6 11550.8 11553.6 11558.8 8166.0 8179.3 8203.5 8213.2 8275.9 13823.8 13830.4 13838.4 13844.4 13879.9 5538.2 5758.2 5767.7 5798.2 5828.0 820.6 882.9 903.2 938.1 1055.4 25511.6 26267.7 26586.1 26926.9 26957.9 925.4 941.4 947.5 1001.9 1043.8 13145.9 13270.0 13332.0 13400.7 13410.9 329393.0 331392.0 333101.0 334752.0 335130.0 45725.5 46242.8 46246.3 46455.8 46493.1 1188.1 1190.0 1199.0 1199.5 1320.2 24138.6 27917.4 29450.6 30066.5 31936.8 44262.8 44830.0 44915.6 44984.6 44993.3 200232.0 201569.0 201990.0 202243.0 202375.0 30367.0 39008.6 39477.4 39870.8 40433.0 36526.3 36769.6 36847.8 37205.4 37217.4 31176.0 31194.4 31525.4 31527.5 32043.0 31171.2 31254.4 31273.8 31504.2 31696.4 31662.2 31893.8 31913.2 33536.0 34379.7 29763.3 30286.4 30395.8 30437.0 30488.2 23776.9 23820.4 23848.9 23971.6 24001.9 08:58:06 INFO - PROCESS | 16153 | 08:58:06 INFO - PROCESS | 16153 | [#2] jquery.html Cycles:180 Average:21908.23 Median:24588.64 stddev:64342.52 (261.7%) stddev-sans-first:64502.59 08:58:06 INFO - PROCESS | 16153 | Values: 313.7 315.7 318.3 324.5 334.8 14112.9 15037.2 15527.6 15550.4 15586.4 13748.5 14194.4 14596.4 14773.9 14877.1 4325.3 4446.7 4459.0 4466.6 4471.7 4409.3 4446.1 4448.1 4643.2 4924.4 4720.6 4851.5 4862.7 4880.3 4886.0 4939.6 4940.2 4955.5 4962.2 4962.5 4649.2 4836.7 4869.5 4874.1 4882.9 11009.1 11225.6 11234.7 11261.9 17410.8 1947.4 2041.6 2044.9 2065.3 2422.1 8069.6 8460.3 8654.2 8690.7 8812.7 1651.4 1702.6 1731.9 1793.0 1831.7 51903.0 52651.0 53390.2 55959.2 57776.0 9081.1 9099.4 9430.1 9465.0 9992.5 12314.3 12352.2 12486.9 12498.6 12520.2 6265.2 6460.8 6464.5 6477.5 6525.1 5942.3 6119.1 6125.4 6150.8 6291.7 4045.4 4069.2 4078.5 4086.4 4105.8 1682.9 1723.3 1734.6 1734.9 1754.9 370.3 719.7 788.9 890.2 909.4 9323.0 9617.7 9927.8 10156.5 10250.1 381.5 399.4 401.4 402.5 416.3 5265.5 5304.6 5351.3 5363.2 5404.2 388511.0 389324.0 390022.0 397272.0 397759.0 48153.0 51963.7 58929.7 67397.0 69015.7 382.2 414.4 416.1 416.4 416.4 9122.9 9158.6 9337.3 9596.8 9612.5 31334.1 32027.8 32195.0 32360.4 32463.8 41420.4 42973.8 43923.8 44056.1 44705.6 7001.1 7016.9 7157.9 7209.5 7214.1 9323.9 11079.4 11199.4 11317.9 11326.8 9189.9 9260.4 9326.3 9577.0 9740.1 5370.9 8116.0 9339.0 9762.5 9848.6 9680.7 9699.1 10041.3 10136.6 10342.6 6916.2 7050.5 7082.5 7143.6 7158.5 7373.3 10020.2 10104.5 10192.0 10291.3 08:58:06 INFO - PROCESS | 16153 | 08:58:06 INFO - PROCESS | 16153 | [#3] mootools.html Cycles:180 Average:4958.66 Median:6079.80 stddev:2699.87 (44.4%) stddev-sans-first:2692.82 08:58:06 INFO - PROCESS | 16153 | Values: 1219.6 1347.8 1354.6 1462.0 1727.1 7011.7 7129.9 7156.9 7173.9 7193.6 6990.5 7158.8 7162.5 7162.8 7173.1 1661.6 1984.7 2030.9 2037.9 2063.4 1993.5 2000.9 2002.5 2003.5 2003.9 1944.9 1961.0 2001.6 2002.3 2003.9 1979.0 2006.2 2010.8 2014.5 2027.8 1989.8 1996.4 1996.7 2000.2 2001.2 7300.9 7335.5 7340.6 7348.6 7355.3 3908.1 3978.7 3996.1 3997.7 3999.9 2518.8 2680.2 2688.9 2697.3 2699.6 826.2 859.6 875.1 875.4 880.9 9774.8 9844.8 9853.8 9866.2 9898.2 3554.3 3669.2 3719.5 3741.9 3765.7 8442.1 8524.3 8529.7 8537.6 8554.4 3536.5 4091.4 4105.3 4111.7 4117.7 3637.5 3699.7 3704.0 3709.9 3712.6 3108.8 3206.4 3212.1 3221.7 3223.5 970.2 985.4 985.5 990.7 998.8 1044.0 1109.9 1114.3 1174.7 1182.1 6854.0 6866.7 6902.6 6943.1 6991.9 424.6 433.1 434.7 434.9 435.2 5011.3 5026.3 5029.5 5029.5 5043.2 8693.9 8751.3 8894.0 8973.5 8977.3 8757.4 8873.1 8891.6 8892.5 8901.4 6564.3 6677.2 6756.2 6765.6 6800.7 6531.4 6669.0 6671.8 6672.2 6672.9 7691.9 7867.8 7931.6 8071.1 8115.3 8042.0 8184.4 8252.5 8332.5 8364.3 5240.4 6024.9 6294.1 6331.7 6333.1 6624.7 6673.7 6679.2 6684.7 6698.4 5989.4 6070.0 6089.6 6141.6 6172.5 5926.3 5963.1 6041.7 6108.6 6113.9 6485.9 6573.8 6581.1 6582.8 6588.8 5940.7 5942.9 5948.1 5965.6 5976.6 5873.7 6038.9 6039.8 6052.5 6127.6 08:58:06 INFO - PROCESS | 16153 | 08:58:06 INFO - PROCESS | 16153 | [#4] prototype.html Cycles:180 Average:4518.23 Median:5227.56 stddev:1349.04 (25.8%) stddev-sans-first:1314.87 08:58:06 INFO - PROCESS | 16153 | Values: 285.2 287.9 288.9 292.5 295.8 5223.8 5231.3 5237.9 5257.2 5307.5 4965.0 5142.7 5176.6 5208.7 5215.7 3796.2 3879.2 3968.2 3973.7 3978.9 4002.3 4015.5 4015.9 4021.2 4025.0 3971.3 3975.8 3982.5 3987.5 3990.5 3754.9 3850.5 3957.5 3976.2 3981.0 3442.4 3447.4 3449.7 3451.9 3461.7 5019.1 5030.2 5030.3 5033.0 5041.8 4557.2 4564.1 4566.0 4570.6 4571.1 5452.7 5459.7 5460.6 5466.4 5471.3 3763.9 3764.4 3768.2 3769.4 3771.3 5561.2 5694.0 5769.1 5790.6 5795.4 3810.4 3819.9 3835.4 3839.9 3840.8 3888.0 3888.2 3891.4 3893.9 3894.6 4509.9 4512.5 4514.4 4520.4 4520.7 5461.1 5474.6 5485.0 5490.3 5493.1 1346.9 1369.0 1369.9 1371.6 1374.7 861.6 882.2 909.1 929.9 930.2 4803.4 4826.3 4843.4 4858.6 4861.9 5664.4 5665.2 5666.8 5668.7 5679.6 4803.9 4842.2 4842.3 4844.7 4849.0 3008.4 3046.1 3046.5 3046.7 3048.9 5367.4 5369.2 5373.2 5382.6 5385.3 5604.6 5736.8 5789.8 5791.7 5802.4 5349.9 5360.5 5372.8 5379.8 5386.3 5631.7 5633.6 5638.1 5641.0 5645.9 5438.8 5493.1 5500.4 5501.8 5509.5 5373.4 5382.8 5386.5 5388.7 5391.3 3685.9 3832.4 3835.2 3839.8 3849.4 5656.9 5675.5 5693.2 5693.4 5695.9 5492.8 5494.2 5496.6 5504.7 5506.1 5483.2 5486.6 5487.4 5494.8 5503.3 5388.1 5390.1 5397.9 5405.5 5406.3 5383.2 5504.4 5526.4 5537.2 5539.4 5378.5 5406.8 5408.0 5412.8 5418.5 08:58:06 INFO - PROCESS | 16153 | 08:58:06 INFO - PROCESS | 16153 | [#5] yui.html Cycles:180 Average:11872.59 Median:42375.89 stddev:13177.02 (31.1%) stddev-sans-first:13186.59 08:58:06 INFO - PROCESS | 16153 | Values: 558.9 588.1 646.6 696.9 700.2 10883.5 12552.9 12787.6 12792.6 12851.7 12662.0 12696.0 12716.2 12749.6 12775.8 594.1 606.0 606.7 608.0 756.9 763.3 769.3 771.2 774.5 776.0 800.7 806.4 806.6 811.9 812.8 620.1 788.3 797.0 798.7 805.7 584.9 584.9 585.1 589.7 589.9 11304.9 11779.7 11804.8 11806.9 11807.3 10896.8 11080.5 11210.6 11309.2 11594.7 9249.1 9438.1 9567.3 9689.6 9728.2 2910.3 2926.9 2928.2 3042.3 3047.9 40696.0 41228.0 41374.0 41447.8 41457.4 8978.4 9025.4 9115.0 9151.2 9180.2 15662.2 15717.8 15752.8 15753.8 15889.7 5965.9 5989.3 6002.1 6195.5 6334.5 3559.4 3633.9 3724.6 3730.2 3738.3 2524.8 2553.2 2555.5 2555.9 2559.4 410.2 461.2 464.5 474.9 476.8 585.4 595.2 595.6 596.7 606.8 7380.7 7590.2 7803.9 7848.6 7867.9 564.6 572.8 574.5 585.3 590.2 3430.9 3515.6 3545.7 3614.5 3734.6 45103.0 45280.8 46282.3 47309.8 48308.8 41614.8 41629.6 42009.4 42202.0 42549.8 38117.4 38759.8 39490.6 39744.6 40001.4 6995.6 7219.0 7599.8 7685.4 7859.2 29948.4 30498.8 30550.5 31150.4 31427.0 33101.3 33821.5 37055.3 37295.6 37675.2 8542.8 8618.4 8658.8 10386.6 10389.4 10991.3 11036.4 11237.7 11275.0 11321.2 10110.7 10383.6 10436.3 10751.0 11239.2 9987.9 10196.1 10249.4 10585.0 10757.9 10297.3 10316.2 10371.6 10616.6 10633.4 8638.0 8850.7 9083.5 9104.9 9263.2 8609.6 8677.0 8892.6 9053.0 9086.6 08:58:06 INFO - PROCESS | 16153 | -------- Summary: end -------- 08:58:06 INFO - PROCESS | 16153 | 08:58:07 INFO - TEST-INFO | 16153: exit 0 08:58:07 INFO - TEST-OK | dromaeo_css | took 1116472ms 08:58:07 INFO - TEST-START | kraken 08:58:07 INFO - operating with platform_type : linux_ 08:58:07 INFO - Initialising browser for kraken test... 08:58:07 INFO - TEST-INFO | started process 16338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2kTQnm/profile http://localhost:51823/getInfo.html) 08:58:11 INFO - PROCESS | 16338 | __metrics Screen width/height:1600/1200 08:58:11 INFO - PROCESS | 16338 | colorDepth:24 08:58:11 INFO - PROCESS | 16338 | Browser inner width/height: 1024/697 08:58:11 INFO - PROCESS | 16338 | __metrics 08:58:12 INFO - PROCESS | 16338 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:58:13 INFO - TEST-INFO | 16338: exit 0 08:58:13 INFO - Browser initialized. 08:58:13 INFO - Running cycle 1/1 for kraken test... 08:58:13 INFO - TEST-INFO | started process 16422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2kTQnm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:24 INFO - PROCESS | 16422 | RSS: Main: 153264128 08:58:24 INFO - PROCESS | 16422 | 08:58:27 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51823/tests/kraken/driver.html?testName=audio-beat-detection) 08:58:28 INFO - PROCESS | 16422 | RSS: Main: 197115904 08:58:28 INFO - PROCESS | 16422 | 08:58:30 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51823/tests/kraken/driver.html?testName=audio-dft) 08:58:31 INFO - PROCESS | 16422 | RSS: Main: 187097088 08:58:31 INFO - PROCESS | 16422 | 08:58:34 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51823/tests/kraken/driver.html?testName=audio-fft) 08:58:35 INFO - PROCESS | 16422 | RSS: Main: 173735936 08:58:35 INFO - PROCESS | 16422 | 08:58:37 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51823/tests/kraken/driver.html?testName=audio-oscillator) 08:58:37 INFO - PROCESS | 16422 | RSS: Main: 175669248 08:58:37 INFO - PROCESS | 16422 | 08:58:40 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:58:40 INFO - PROCESS | 16422 | RSS: Main: 174010368 08:58:40 INFO - PROCESS | 16422 | 08:58:43 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51823/tests/kraken/driver.html?testName=imaging-darkroom) 08:58:44 INFO - PROCESS | 16422 | RSS: Main: 176418816 08:58:44 INFO - PROCESS | 16422 | 08:58:47 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51823/tests/kraken/driver.html?testName=imaging-desaturate) 08:58:48 INFO - PROCESS | 16422 | RSS: Main: 177135616 08:58:48 INFO - PROCESS | 16422 | 08:58:51 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51823/tests/kraken/driver.html?testName=json-parse-financial) 08:58:51 INFO - PROCESS | 16422 | RSS: Main: 176316416 08:58:51 INFO - PROCESS | 16422 | 08:58:53 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:58:54 INFO - PROCESS | 16422 | RSS: Main: 187940864 08:58:54 INFO - PROCESS | 16422 | 08:58:56 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51823/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:58:56 INFO - PROCESS | 16422 | RSS: Main: 183828480 08:58:56 INFO - PROCESS | 16422 | 08:58:58 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:58:59 INFO - PROCESS | 16422 | RSS: Main: 196472832 08:58:59 INFO - PROCESS | 16422 | 08:59:01 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:02 INFO - PROCESS | 16422 | RSS: Main: 199258112 08:59:02 INFO - PROCESS | 16422 | 08:59:05 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:05 INFO - PROCESS | 16422 | RSS: Main: 199643136 08:59:05 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | Cycle 1(1): loaded http://localhost:51823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51823/tests/kraken/driver.html?testName=ai-astar) 08:59:07 INFO - PROCESS | 16422 | RSS: Main: 259518464 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | __start_tp_report 08:59:07 INFO - PROCESS | 16422 | _x_x_mozilla_page_load 08:59:07 INFO - PROCESS | 16422 | _x_x_mozilla_page_load_details 08:59:07 INFO - PROCESS | 16422 | |i|pagename|runs| 08:59:07 INFO - PROCESS | 16422 | |0;ai-astar;114;114;110;116;115;115;105;113;113;116 08:59:07 INFO - PROCESS | 16422 | |1;audio-beat-detection;164;144;158;174;136;154;156;141;189;135 08:59:07 INFO - PROCESS | 16422 | |2;audio-dft;164;163;163;164;163;163;165;163;163;164 08:59:07 INFO - PROCESS | 16422 | |3;audio-fft;74;74;75;157;74;73;74;75;152;73 08:59:07 INFO - PROCESS | 16422 | |4;audio-oscillator;95;96;151;95;95;95;145;95;97;136 08:59:07 INFO - PROCESS | 16422 | |5;imaging-gaussian-blur;116;117;117;117;117;117;118;117;117;117 08:59:07 INFO - PROCESS | 16422 | |6;imaging-darkroom;147;148;147;146;147;146;146;146;146;146 08:59:07 INFO - PROCESS | 16422 | |7;imaging-desaturate;95;96;95;95;96;95;95;96;96;96 08:59:07 INFO - PROCESS | 16422 | |8;json-parse-financial;66;65;67;67;65;66;66;75;64;64 08:59:07 INFO - PROCESS | 16422 | |9;json-stringify-tinderbox;71;72;70;71;72;75;72;71;72;71 08:59:07 INFO - PROCESS | 16422 | |10;stanford-crypto-aes;83;83;86;84;83;84;84;84;83;84 08:59:07 INFO - PROCESS | 16422 | |11;stanford-crypto-ccm;134;121;118;123;127;122;132;121;126;122 08:59:07 INFO - PROCESS | 16422 | |12;stanford-crypto-pbkdf2;156;142;153;162;151;146;167;165;153;153 08:59:07 INFO - PROCESS | 16422 | |13;stanford-crypto-sha256-iterative;70;71;71;74;72;74;72;71;70;70 08:59:07 INFO - PROCESS | 16422 | __end_tp_report 08:59:07 INFO - PROCESS | 16422 | __start_cc_report 08:59:07 INFO - PROCESS | 16422 | _x_x_mozilla_cycle_collect,1138 08:59:07 INFO - PROCESS | 16422 | __end_cc_report 08:59:07 INFO - PROCESS | 16422 | __startTimestamp1456937947857__endTimestamp 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | ------- Summary: start ------- 08:59:07 INFO - PROCESS | 16422 | Number of tests: 14 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.50 stddev:3.35 (2.9%) stddev-sans-first:3.54 08:59:07 INFO - PROCESS | 16422 | Values: 114.0 114.0 110.0 116.0 115.0 115.0 105.0 113.0 113.0 116.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:157.00 stddev:17.28 (11.0%) stddev-sans-first:18.02 08:59:07 INFO - PROCESS | 16422 | Values: 164.0 144.0 158.0 174.0 136.0 154.0 156.0 141.0 189.0 135.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 08:59:07 INFO - PROCESS | 16422 | Values: 164.0 163.0 163.0 164.0 163.0 163.0 165.0 163.0 163.0 164.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#3] audio-fft Cycles:10 Average:90.10 Median:74.00 stddev:33.97 (45.9%) stddev-sans-first:35.53 08:59:07 INFO - PROCESS | 16422 | Values: 74.0 74.0 75.0 157.0 74.0 73.0 74.0 75.0 152.0 73.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:95.00 stddev:23.74 (25.0%) stddev-sans-first:24.55 08:59:07 INFO - PROCESS | 16422 | Values: 95.0 96.0 151.0 95.0 95.0 95.0 145.0 95.0 97.0 136.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 08:59:07 INFO - PROCESS | 16422 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 08:59:07 INFO - PROCESS | 16422 | Values: 147.0 148.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:59:07 INFO - PROCESS | 16422 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.00 stddev:3.17 (4.8%) stddev-sans-first:3.36 08:59:07 INFO - PROCESS | 16422 | Values: 66.0 65.0 67.0 67.0 65.0 66.0 66.0 75.0 64.0 64.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:1.34 (1.9%) stddev-sans-first:1.39 08:59:07 INFO - PROCESS | 16422 | Values: 71.0 72.0 70.0 71.0 72.0 75.0 72.0 71.0 72.0 71.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 08:59:07 INFO - PROCESS | 16422 | Values: 83.0 83.0 86.0 84.0 83.0 84.0 84.0 84.0 83.0 84.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:124.50 stddev:5.13 (4.1%) stddev-sans-first:4.16 08:59:07 INFO - PROCESS | 16422 | Values: 134.0 121.0 118.0 123.0 127.0 122.0 132.0 121.0 126.0 122.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:154.50 stddev:7.97 (5.2%) stddev-sans-first:8.44 08:59:07 INFO - PROCESS | 16422 | Values: 156.0 142.0 153.0 162.0 151.0 146.0 167.0 165.0 153.0 153.0 08:59:07 INFO - PROCESS | 16422 | 08:59:07 INFO - PROCESS | 16422 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.51 (2.1%) stddev-sans-first:1.50 08:59:07 INFO - PROCESS | 16422 | Values: 70.0 71.0 71.0 74.0 72.0 74.0 72.0 71.0 70.0 70.0 08:59:07 INFO - PROCESS | 16422 | -------- Summary: end -------- 08:59:07 INFO - PROCESS | 16422 | 08:59:08 INFO - TEST-INFO | 16422: exit 0 08:59:08 INFO - TEST-OK | kraken | took 61699ms 08:59:08 INFO - SUITE-END | took 1178s 08:59:09 INFO - Completed test suite (00:19:38) 08:59:09 INFO - Working with test: dromaeo_css 08:59:09 INFO - Generating results file: dromaeo_css 08:59:09 INFO - Working with test: kraken 08:59:09 INFO - Generating results file: kraken 08:59:09 INFO - javascript benchmark 08:59:09 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:59:09 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 08:59:09 INFO - process_Request line: dromaeo_css 5938.59 graph.html#tests=[[72,132,35]] 08:59:09 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:59:09 INFO - process_Request line: kraken 1563.70 graph.html#tests=[[232,132,35]] 08:59:09 INFO - RETURN: dromaeo_css: 5938.59 08:59:09 INFO - RETURN: kraken: 1563.70 08:59:09 INFO - javascript benchmark 08:59:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2588.8964441422345, 2664.7868170546344, 2679.2765953192625, 2684.3960108975484, 2709.6477457930464, 4402.075564131536, 4494.348319493672, 4550.203714349988, 4554.066416384641, 4561.635069194464, 4569.246074397721, 4575.611073058794, 4614.723116613006, 4625.213713668676, 4674.766261686919, 4138.089620283533, 4156.189543039109, 4223.957760422395, 4269.573042695721, 4271.103068355649, 4227.704060715751, 4288.892777680552, 4294.312909934395, 4295.548967358429, 4318.762468064255, 4061.147159096608, 4158.812853421603, 4219.092895027553, 4270.14597080582, 4278.251306021434, 4165.770882601456, 4177.352510360899, 4181.665466762652, 4212.515560710527, 4227.32362821947, 4015.3976903464713, 4156.688248381353, 4165.0, 4187.602177793105, 4225.091605304874, 4415.8233670653135, 4416.779161041935, 4479.484859241196, 4493.191225579394, 4520.367148599199, 4800.303955926406, 4807.831725889612, 4811.398575178103, 4814.494478079821, 4832.1543729847135, 4670.859874203779, 4823.372961515016, 4841.830535931261, 4847.369841920563, 4895.755212239409, 4555.794989225493, 4559.361689363492, 4565.315202719618, 4565.657575681771, 4603.5856772890265, 4955.207166853286, 4996.475370086088, 5005.299258103868, 5050.292958985745, 5056.797728090909, 4617.191991401492, 4789.161896668069, 4793.0, 4820.783064762094, 4885.97394547142, 4848.660593758474, 4861.197902346144, 4867.123917694849, 4899.240617704261, 4913.557779799835, 4806.303086052572, 4808.591269742041, 4812.687175333662, 4812.879678008007, 4860.538248866352, 4614.7461889595725, 4752.7623618818925, 4811.158047341702, 4840.370751802243, 4841.661083724105, 4029.5366032906004, 4041.535223449341, 4049.149678567534, 4055.411965265079, 4073.9388909166387, 3587.2287458196092, 3587.2466781976077, 3598.0105470995163, 3598.082488965297, 3622.130688634709, 4090.81591328385, 4188.769617670996, 4190.748555086705, 4286.249906266453, 4289.849855255051, 4873.439554451213, 4895.853124406273, 4901.0, 4901.607871370282, 4930.605551555867, 4237.449131612871, 4255.255330317182, 4256.59562341577, 4257.063446041866, 4281.272183728774, 4179.853705120367, 4263.211305908417, 4313.6980411370905, 4315.503717072514, 4345.847895323648, 4599.379083823641, 4610.608098311681, 4611.723296602215, 4612.169809434334, 4659.20793465105, 4656.068786242698, 4803.0, 4820.758962051954, 4822.855314340575, 4865.781039853145, 4572.908541829212, 4709.081729062937, 4720.740359280273, 4726.550977657117, 4755.952440475689, 4771.618270538418, 4773.9761301193275, 4783.497732738012, 4789.473157952552, 4807.543283388072, 4661.976690116663, 4835.081334546425, 4846.903061938812, 4889.168841297059, 4906.509349065065, 4675.742834144019, 4679.2045352289515, 4684.391029166187, 4689.835855745033, 4724.173269677862, 4661.230896902109, 4684.789184486638, 4690.460597031385, 4743.027679325661, 4748.691335063348, 4481.529439408815, 4616.076784643018, 4627.1439783640135, 4659.4175728034, 4756.167670657552, 4751.097291514601, 4760.143174228672, 4770.236762118045, 4798.088363210979, 4822.0, 4670.1126785910565, 4674.368960190467, 4676.906461870812, 4699.882502937454, 4722.079194557028], "unit": "score", "name": "dojo.html", "value": 4466.200925292055}, {"lowerIsBetter": false, "replicates": [486.60341821415545, 488.81425058477794, 492.69452939177717, 506.36956988549264, 519.5765451157306, 26746.197614071585, 33430.0, 33451.49822752661, 33607.15982100449, 33646.15884602883, 36332.81833590828, 36728.674342220365, 36921.44617830728, 36936.81531592345, 36986.26027479449, 7670.079590449154, 7868.0, 7869.134395216522, 7869.921300786976, 7872.5670088145125, 7826.060872695256, 7977.601119944009, 7993.08079570851, 7998.800029999267, 8006.479578827358, 7920.881186782203, 7979.720709775159, 8000.919990800105, 8001.559914204717, 8008.398320335927, 7924.960375198145, 7991.440599158062, 8006.599670016476, 8015.7194498192575, 8017.719379821737, 7800.375969922393, 7866.488678235896, 7931.087924888654, 7940.0868900076075, 7943.285104340579, 36558.45162322541, 37347.62652373469, 37353.81323093394, 37360.25279494422, 37378.81310593457, 2879.3233590106306, 3035.8178509289514, 3304.5043243513423, 3632.9273414531826, 3713.9814300928324, 26466.86766566155, 26517.867410663017, 26847.194584162506, 27793.722062779314, 27823.0, 3036.3016506203476, 3081.168084617163, 3113.3306339137193, 3117.485614873543, 3134.49848024315, 222130.0, 224836.0, 225989.0, 227727.0, 227740.0, 39313.41029884554, 57014.42985570174, 57910.0, 57962.13056804067, 58042.419575804546, 39212.6078739209, 39733.60266397357, 39837.0, 39857.80071099626, 39859.800700996886, 11266.493007814668, 11542.59600913964, 11550.826737598944, 11553.595624153115, 11558.826617600742, 8165.959170204111, 8179.345652347798, 8203.466774659628, 8213.178682131738, 8275.875861862078, 13823.79264311036, 13830.446782128602, 13838.446462141603, 13844.377003034888, 13879.861201387857, 5538.154115149245, 5758.193852860602, 5767.711614419262, 5798.159266906359, 5828.009238429478, 820.5815034332534, 882.9161229683169, 903.1781079217881, 938.0994245524373, 1055.4247934875511, 25511.617325740128, 26267.737322626912, 26586.069487567842, 26926.865365673046, 26957.865210673823, 925.379995403068, 941.3928016429502, 947.4978261521404, 1001.9248556358302, 1043.7703705185, 13145.934270328778, 13269.982176281155, 13332.0, 13400.664983375493, 13410.932945335211, 329393.0, 331392.0, 333101.0, 334752.0, 335130.0, 45725.54274457279, 46242.76878615585, 46246.306305405444, 46455.76772116118, 46493.07013859704, 1188.1385995153616, 1189.9825649070094, 1199.0347770045198, 1199.5441732141906, 1320.1551007355301, 24138.637920430858, 27917.441651167268, 29450.558241626823, 30066.549001764553, 31936.840315799203, 44262.778686106365, 44830.0, 44915.55084449114, 44984.550154498036, 44993.32510012287, 200232.0, 201569.0, 201990.0, 202243.0, 202375.0, 30367.0, 39008.609913900495, 39477.40783888187, 39870.80064599658, 40433.0, 36526.26947461089, 36769.63230367662, 36847.815760922094, 37205.44191837071, 37217.4417383734, 31176.0, 31194.376112478076, 31525.36949260956, 31527.527087093255, 32043.0, 31171.220719482193, 31254.374912501167, 31273.8436307817, 31504.2123946894, 31696.36607267888, 31662.208444789063, 31893.8405307972, 31913.202169945936, 33536.0, 34379.656203438644, 29763.255918602208, 30286.394272114874, 30395.848020759753, 30437.0, 30488.237794055327, 23776.88111559431, 23820.404489887198, 23848.88075559611, 23971.640425393285, 24001.879990599937], "unit": "score", "name": "ext.html", "value": 16200.382181511048}, {"lowerIsBetter": false, "replicates": [313.7192212969392, 315.7316281161013, 318.29338867713665, 324.54077480365254, 334.81752444917504, 14112.858871411283, 15037.172955487444, 15527.611809704735, 15550.377984880606, 15586.376544938203, 13748.518801841938, 14194.36125374358, 14596.416143354252, 14773.92613036936, 14877.107373557594, 4325.2647050001415, 4446.688731788776, 4458.97770511147, 4466.553344665524, 4471.731696098244, 4409.272470042455, 4446.133004064209, 4448.110377924412, 4643.210654188796, 4924.384451943507, 4720.575148236658, 4851.539103785135, 4862.683925544846, 4880.316755654194, 4886.0, 4939.555440010398, 4940.209566469348, 4955.4548999610015, 4962.156433406293, 4962.45413004571, 4649.232876575395, 4836.733979631119, 4869.5130486951375, 4874.147024270738, 4882.853514394538, 11009.064229540418, 11225.607103751412, 11234.719132021683, 11261.943690281578, 17410.825891741046, 1947.3963071447754, 2041.6427125253022, 2044.9079791409422, 2065.3390914907236, 2422.140140250221, 8069.596520173968, 8460.280876125536, 8654.177853103945, 8690.652373905099, 8812.735617931472, 1651.405494022163, 1702.608400067979, 1731.9480415587427, 1792.9641407171914, 1831.6886129357908, 51903.0, 52651.0, 53390.19914701283, 55959.16061259125, 57776.0, 9081.091890810998, 9099.408538444979, 9430.10414010668, 9465.0, 9992.500374981222, 12314.322712250732, 12352.197107188184, 12486.875131248571, 12498.625041248777, 12520.186187897758, 6265.216847894013, 6460.806175814733, 6464.547481676237, 6477.546571739933, 6525.053867189231, 5942.346341902387, 6119.051547010221, 6125.387461253839, 6150.846228844314, 6291.748330066746, 4045.3931910213705, 4069.2268468990796, 4078.530968938551, 4086.3870419436726, 4105.794710264475, 1682.8906121102088, 1723.276223985929, 1734.6270551831417, 1734.8612111031086, 1754.859341428082, 370.25948103792416, 719.7301012120455, 788.8777239527882, 890.247740659142, 909.3907082254905, 9323.0, 9617.663381781744, 9927.80144397108, 10156.4921753912, 10250.128739057263, 381.45261549676303, 399.4308110941896, 401.37185304998167, 402.53306164848635, 416.3151615592394, 5265.473452654704, 5304.628675992643, 5351.25082488452, 5363.168708850135, 5404.216388623706, 388511.0, 389324.0, 390022.0, 397272.0, 397759.0, 48153.0, 51963.740181298854, 58929.70535147297, 67397.0, 69015.65492172507, 382.2107348325754, 414.4136047492824, 416.0949933893829, 416.37959440433536, 416.4232537934921, 9122.908770912207, 9158.633654653739, 9337.299702522203, 9596.76008099803, 9612.471314077793, 31334.05997820069, 32027.83986080055, 32195.0, 32360.352792943537, 32463.837680811444, 41420.378694319006, 42973.785131074146, 43923.78038109789, 44056.11887762163, 44705.55294447144, 7001.124859392576, 7016.859662806817, 7157.892631610634, 7209.531380460253, 7214.098237720285, 9323.860142097737, 11079.390633515233, 11199.440027998731, 11317.886821132013, 11326.83009754871, 9189.908100918905, 9260.351775375659, 9326.300527460331, 9577.0, 9740.12338889475, 5370.892582148414, 8115.959420202861, 9339.0, 9762.511874406393, 9848.556814943202, 9680.709578712649, 9699.127078562964, 10041.347312424668, 10136.645217417356, 10342.638007669695, 6916.170059592881, 7050.506464547432, 7082.4688148390105, 7143.607101609461, 7158.46311526648, 7373.33639972405, 10020.24848136378, 10104.545295461576, 10192.0, 10291.279610427198], "unit": "score", "name": "jquery.html", "value": 6796.437179461149}, {"lowerIsBetter": false, "replicates": [1219.5609580550995, 1347.8382594088707, 1354.6274774437024, 1461.9780703289453, 1727.0673836128492, 7011.684474198661, 7129.85740285194, 7156.928430715704, 7173.892391614117, 7193.640317984099, 6990.5456145350645, 7158.785236442902, 7162.462815288861, 7162.820929476766, 7173.139223293199, 1661.6261341198256, 1984.7122167285736, 2030.8781473111624, 2037.908294126768, 2063.3912995666237, 1993.4717299915535, 2000.9299674511394, 2002.499375156211, 2003.459066052165, 2003.8597298189134, 1944.8833070015774, 1961.0292905012038, 2001.629698505781, 2002.3492364981366, 2003.9398818035481, 1978.980210197894, 2006.1674405121857, 2010.7888671689482, 2014.4762361785968, 2027.787082356346, 1989.7910719374402, 1996.4110587376758, 1996.6805311150292, 2000.1799262302532, 2001.2295266322426, 7300.926990730078, 7335.5231909926215, 7340.559566426032, 7348.559086454777, 7355.301246381585, 3908.062065104383, 3978.661813745835, 3996.100877302613, 3997.6601988830985, 3999.9400008999887, 2518.7859031982302, 2680.2227354067295, 2688.90588829392, 2697.298702337406, 2699.595060740885, 826.1531929771971, 859.5616235719765, 875.1379890807549, 875.4353442029856, 880.9295256379474, 9774.75563110928, 9844.753881153028, 9853.753656158653, 9866.210703143803, 9898.158656514204, 3554.2891421715244, 3669.192777588926, 3719.479272901796, 3741.9438708419398, 3765.7175711821724, 8442.07137214906, 8524.318054555744, 8529.701460448854, 8537.615807288686, 8554.35842311829, 3536.45184996326, 4091.365838295069, 4105.34314509677, 4111.691623128278, 4117.670586353084, 3637.454381842692, 3699.667029967316, 3704.0, 3709.9443508347395, 3712.6287371263197, 3108.8290144041844, 3206.4228438881223, 3212.1327241644626, 3221.7261532769508, 3223.5164725291393, 970.2044323654677, 985.4136788610765, 985.5023213277392, 990.6582229130938, 998.8152191844532, 1044.013298268254, 1109.8890110988998, 1114.3091283404342, 1174.723939874129, 1182.1252273317682, 6853.965730171317, 6866.725330986705, 6902.5858448492245, 6943.132108486439, 6991.860162796817, 424.63057140288146, 433.0624198609974, 434.71960585422227, 434.8847555397822, 435.16448419035527, 5011.298418221452, 5026.346574945233, 5029.471905449948, 5029.547340739351, 5043.193089105799, 8693.869591956125, 8751.299896008431, 8893.955530222307, 8973.461592304482, 8977.281817454588, 8757.386982911135, 8873.112688731204, 8891.555422228863, 8892.510911899908, 8901.421407608614, 6564.27372291949, 6677.165354330708, 6756.155480564929, 6765.560238584476, 6800.727970881208, 6531.412172904462, 6669.0329902164885, 6671.83320416974, 6672.165979252593, 6672.899906501503, 7691.923080769345, 7867.803304917423, 7931.60341982887, 8071.112177660335, 8115.310198632947, 8041.959790201246, 8184.386171037077, 8252.504849708797, 8332.541710205996, 8364.289035432057, 5240.423553409199, 6024.9397506026135, 6294.0558916162945, 6331.651759153291, 6333.050042493663, 6624.668766561749, 6673.699683514351, 6679.198496180489, 6684.699188536625, 6698.363655452724, 5989.371116032754, 6069.969650151721, 6089.634621922699, 6141.631502109888, 6172.475339596184, 5926.259217597801, 5963.135345374983, 6041.667708276087, 6108.633481991094, 6113.908291375722, 6485.870282594227, 6573.835654108494, 6581.144451221502, 6582.80251592453, 6588.769393071219, 5940.673262970578, 5942.851428714317, 5948.10778383246, 5965.582409231486, 5976.581639285208, 5873.73568189424, 6038.882806680603, 6039.78860739872, 6052.515798736179, 6127.632342059313], "unit": "score", "name": "mootools.html", "value": 3947.466828013932}, {"lowerIsBetter": false, "replicates": [285.1530953069384, 287.9424115176965, 288.8786709581975, 292.472087881374, 295.7855554722825, 5223.817166399177, 5231.293775340333, 5237.895242095161, 5257.237700533425, 5307.52232299093, 4964.950350496494, 5142.7428628568605, 5176.58587313015, 5208.7395630218525, 5215.713135777531, 3796.2027974125467, 3879.2047630235734, 3968.16668499614, 3973.6821054315656, 3978.9403158952637, 4002.3196056670436, 4015.4980627421573, 4015.9397609035886, 4021.235965166624, 4024.9597504024878, 3971.305021621219, 3975.761454312736, 3982.4822773039464, 3987.4816273884353, 3990.501187351581, 3754.887353379403, 3850.4994350734505, 3957.465742124834, 3976.2445135424177, 3981.024648961023, 3442.4492081266876, 3447.3622379859808, 3449.6550344965553, 3451.913702157466, 3461.671141241578, 5019.121653710586, 5030.220315851049, 5030.2957585938, 5033.043721692903, 5041.823536176216, 4557.248054071074, 4564.087182563468, 4565.977170114162, 4570.611498022672, 4571.131485017836, 5452.672839629635, 5459.69971651559, 5460.590455715837, 5466.371367292772, 5471.343438787331, 3763.9247215055548, 3764.416515440111, 3768.1521657626813, 3769.379166958207, 3771.264603402338, 5561.193626924073, 5693.971530142364, 5769.105788602773, 5790.623609465413, 5795.420457954171, 3810.3522401191863, 3819.904502387407, 3835.4438606401914, 3839.9424008639894, 3840.7503512271614, 3887.9805600971813, 3888.16404473034, 3891.3579259422445, 3893.922121557553, 3894.6494815466745, 4509.887252818706, 4512.548745125461, 4514.390557274726, 4520.434945631796, 4520.706154099973, 5461.0716178249795, 5474.562035037187, 5485.0, 5490.313710786152, 5493.066178749622, 1346.912450690702, 1368.9657758556116, 1369.8767110960061, 1371.5542448704011, 1374.6838227207797, 861.6381119929645, 882.1972005475116, 909.1090731083575, 929.8558723397884, 930.186087173723, 4803.447603525569, 4826.276058591239, 4843.4430040545085, 4858.58702010326, 4861.854144375674, 5664.433556644385, 5665.235193248941, 5666.801661941812, 5668.659880407106, 5679.574031947538, 4803.927941080817, 4842.249451335048, 4842.297866809293, 4844.660873738804, 4848.9757551212015, 3008.3832814273023, 3046.131852422049, 3046.466868298039, 3046.6800985896607, 3048.8628011739524, 5367.436419176009, 5369.19462080691, 5373.247745315659, 5382.596305277119, 5385.272988146628, 5604.60767746262, 5736.827895163152, 5789.797357092481, 5791.710414479344, 5802.361740208658, 5349.919751203735, 5360.544353729977, 5372.785088596413, 5379.811706590329, 5386.326709161355, 5631.746571404378, 5633.605647604629, 5638.097904335286, 5641.0, 5645.887082258414, 5438.809641662523, 5493.121100623881, 5500.367457742411, 5501.834944951498, 5509.47659972302, 5373.35519737634, 5382.811601593926, 5386.542143917811, 5388.676679399248, 5391.32608423947, 3685.852565897334, 3832.4251362295877, 3835.1562656215588, 3839.8080095995647, 3849.441830934443, 5656.886862262814, 5675.489205971482, 5693.202951586864, 5693.4021927696995, 5695.857603559944, 5492.780288788404, 5494.1758736189895, 5496.587755918402, 5504.669719816824, 5506.1190209566275, 5483.2049352844415, 5486.615936884539, 5487.396386397573, 5494.835154945358, 5503.3120859892515, 5388.110961691277, 5390.05674007055, 5397.892042159214, 5405.5135037846785, 5406.2701535292235, 5383.219433182245, 5504.422035686195, 5526.447355264441, 5537.169424586184, 5539.446055394428, 5378.515933565998, 5406.810761623325, 5407.972485227794, 5412.83761487156, 5418.512333889968], "unit": "score", "name": "prototype.html", "value": 4078.81134397052}, {"lowerIsBetter": false, "replicates": [558.941311162328, 588.0767195503059, 646.6411141816291, 696.9198542167649, 700.1737949219919, 10883.510242039107, 12552.937235313822, 12787.552435664753, 12792.616221513346, 12851.678708032305, 12662.0, 12696.0, 12716.173448725849, 12749.617511474647, 12775.808362874564, 594.0969726016442, 606.0454783715644, 606.6572386601578, 607.9878402431949, 756.9016027916363, 763.2787016269627, 769.3037800790294, 771.1709911844762, 774.4965772248028, 776.0415886380316, 800.6997375984006, 806.4395245304515, 806.5644551941973, 811.8701007838747, 812.7683610171102, 620.0667994668019, 788.3102285500187, 796.9641366138537, 798.6765360029198, 805.6696754330726, 584.8947189505888, 584.9181114643953, 585.0843430031987, 589.7287247865987, 589.8849724303763, 11304.886951130466, 11779.7055073623, 11804.822927656092, 11806.940965295204, 11807.29156250619, 10896.78206435867, 11080.501377438035, 11210.551577936872, 11309.208355415125, 11594.6521604352, 9249.121333473377, 9438.103380178873, 9567.282453815922, 9689.612415503441, 9728.221742260603, 2910.286979689968, 2926.941461170786, 2928.209383466452, 3042.2698552347497, 3047.9238019049703, 40696.0, 41228.0, 41374.0, 41447.792761036304, 41457.378139327935, 8978.416402933788, 9025.41334813235, 9115.0, 9151.222146117521, 9180.219681327162, 15662.216889155497, 15717.842821571638, 15752.842471575137, 15753.763693544606, 15889.682206355808, 5965.910511342333, 5989.341172471025, 6002.129691194839, 6195.473384762346, 6334.461570766444, 3559.394902866519, 3633.8728144514816, 3724.5530536335814, 3730.2166545025307, 3738.3084129435597, 2524.835885667426, 2553.1957433408415, 2555.514452254103, 2555.9361015974378, 2559.436923876744, 410.2226281197115, 461.22053729197546, 464.53314419009354, 474.9382580264544, 476.790212306584, 585.4438283630568, 595.2083728640897, 595.5860676829562, 596.6718304932269, 606.7876243314804, 7380.704771809175, 7590.203028682019, 7803.882941755878, 7848.607569621496, 7867.921320786833, 564.6358099026105, 572.8485743655283, 574.5174053794832, 585.3122580967431, 590.2297501760158, 3430.9142271442915, 3515.5781306243416, 3545.7163426925786, 3614.512040874501, 3734.607866174067, 45103.0, 45280.77359613181, 46282.30576541355, 47309.76345118252, 48308.7584562082, 41614.791926040176, 41629.583704163175, 42009.369859452134, 42202.0, 42549.78725106417, 38117.428238576445, 38759.806200968815, 39490.605093948696, 39744.60255397467, 40001.39997900092, 6995.580265184105, 7219.0, 7599.810004749926, 7685.385169186564, 7859.214078592095, 29948.401031978803, 30498.84750576233, 30550.541741874335, 31150.37699245957, 31427.0, 33101.33797323992, 33821.49267760936, 37055.258894822495, 37295.64339209484, 37675.2464950694, 8542.78643033929, 8618.396712230335, 8658.783530411538, 10386.636467723594, 10389.37663740178, 10991.285566438157, 11036.425197007566, 11237.719057023312, 11275.0, 11321.150913681342, 10110.69667909964, 10383.636572719919, 10436.321639093434, 10751.0, 11239.213255072067, 9987.900120998696, 10196.133328667147, 10249.436281004617, 10585.047345738612, 10757.9462102689, 10297.279190456597, 10316.226283028953, 10371.58513659445, 10616.575336986434, 10633.415162166155, 8638.0, 8850.73447796567, 9083.478694243708, 9104.863427048467, 9263.16631503168, 8609.569521524025, 8677.0, 8892.59983300766, 9053.0, 9086.591103400231], "unit": "score", "name": "yui.html", "value": 5539.3713290936585}], "name": "dromaeo_css", "value": 5938.59319080706}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 114.0, 110.0, 116.0, 115.0, 115.0, 105.0, 113.0, 113.0, 116.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [164.0, 144.0, 158.0, 174.0, 136.0, 154.0, 156.0, 141.0, 189.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 155.1}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 164.0, 163.0, 163.0, 165.0, 163.0, 163.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 75.0, 157.0, 74.0, 73.0, 74.0, 75.0, 152.0, 73.0], "unit": "score", "name": "audio-fft", "value": 90.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 151.0, 95.0, 95.0, 95.0, 145.0, 95.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 67.0, 65.0, 66.0, 66.0, 75.0, 64.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.5}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 70.0, 71.0, 72.0, 75.0, 72.0, 71.0, 72.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.7}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 86.0, 84.0, 83.0, 84.0, 84.0, 84.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [134.0, 121.0, 118.0, 123.0, 127.0, 122.0, 132.0, 121.0, 126.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.6}, {"lowerIsBetter": true, "replicates": [156.0, 142.0, 153.0, 162.0, 151.0, 146.0, 167.0, 165.0, 153.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.8}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 74.0, 72.0, 74.0, 72.0, 71.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1563.6999999999998}]} 08:59:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1563.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "5938.59"}}} 08:59:09 INFO - Return code: 0 08:59:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:59:09 INFO - # TBPL SUCCESS # 08:59:09 INFO - Running post-action listener: _resource_record_post_action 08:59:09 INFO - Running post-run listener: _resource_record_post_run 08:59:10 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 530173952; Read time: 0; Write time: 453596 08:59:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241217536; Read time: 0; Write time: 272768 08:59:10 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288956416; Read time: 0; Write time: 180828 08:59:10 INFO - Running post-run listener: _upload_blobber_files 08:59:10 INFO - Blob upload gear active. 08:59:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:10 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 08:59:10 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'] 08:59:10 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 08:59:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:59:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:59:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:59:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:11 INFO - (blobuploader) - INFO - Done attempting. 08:59:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:59:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:59:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:12 INFO - (blobuploader) - INFO - Done attempting. 08:59:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:59:12 INFO - Return code: 0 08:59:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:59:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:59:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8118fcf74e8eeaedb68d76db7f98b3db45dc9523dfe34029b89529560153e920fae5e2331b0a57276d88eee4692659d50ce8b7c4d2b1dee3d4e743ff1016ef3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8cd714c8fdc511cb5221706c076fc03ef121e1286ccb20daf799ad58038f40476c36281a88215f38fb2d120e9e074f775484f44443bf956ef39029eb76fb2997"} 08:59:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:59:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:59:12 INFO - Contents: 08:59:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8118fcf74e8eeaedb68d76db7f98b3db45dc9523dfe34029b89529560153e920fae5e2331b0a57276d88eee4692659d50ce8b7c4d2b1dee3d4e743ff1016ef3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8cd714c8fdc511cb5221706c076fc03ef121e1286ccb20daf799ad58038f40476c36281a88215f38fb2d120e9e074f775484f44443bf956ef39029eb76fb2997"} 08:59:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:59:12 INFO - Copying logs to upload dir... 08:59:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:59:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.585044 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-02 08:59:11.041831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 08:59:11.045419) ========= 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=6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8118fcf74e8eeaedb68d76db7f98b3db45dc9523dfe34029b89529560153e920fae5e2331b0a57276d88eee4692659d50ce8b7c4d2b1dee3d4e743ff1016ef3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8cd714c8fdc511cb5221706c076fc03ef121e1286ccb20daf799ad58038f40476c36281a88215f38fb2d120e9e074f775484f44443bf956ef39029eb76fb2997"} build_url:https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/OVv3oVnjT5iWktSlbgwxpQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8118fcf74e8eeaedb68d76db7f98b3db45dc9523dfe34029b89529560153e920fae5e2331b0a57276d88eee4692659d50ce8b7c4d2b1dee3d4e743ff1016ef3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8cd714c8fdc511cb5221706c076fc03ef121e1286ccb20daf799ad58038f40476c36281a88215f38fb2d120e9e074f775484f44443bf956ef39029eb76fb2997"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 08:59:11.070889) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:59:11.071229) ========= 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=6dbc10da6d83fee962c624be000001a8-1456934719.633520-453444246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:59:11.153861) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 08:59:11.154183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 08:59:11.154476) ========= ========= Total master_lag: 0.31 =========