builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1458773020.35 results: success (0) buildid: 20160323145252 builduid: 51edfbf8bcec4dc99eefaf57ef5ee958 revision: 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.347001) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.348462) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.349628) ========= 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=7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006489 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.411349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.412100) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.484734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.485360) ========= 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=7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.567882) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.568456) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.568837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.569149) ========= 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=7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-23 15:43:41-- 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% 96.7M=0s 2016-03-23 15:43:41 (96.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176354 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.775357) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.776036) ========= 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=7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019405 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.852103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:40.852463) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 --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 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 --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=7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-23 15:43:41,674 truncating revision to first 12 chars 2016-03-23 15:43:41,674 Setting DEBUG logging. 2016-03-23 15:43:41,674 attempt 1/10 2016-03-23 15:43:41,674 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7b0bb5c3ab01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 15:43:42,056 unpacking tar archive at: fx-team-7b0bb5c3ab01/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849997 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:41.732516) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:41.732903) ========= echo 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1'] 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=7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 program finished with exit code 0 elapsedTime=0.004792 script_repo_revision: '7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1' ========= master_lag: 0.09 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:41.823238) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:41.823560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 15:43:41.912459) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-03-23 15:43:41.912814) ========= /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=7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:43:42 INFO - MultiFileLogger online at 20160323 15:43:42 in /builds/slave/test 15:43:42 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 15:43:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:43:42 INFO - {'append_to_log': False, 15:43:42 INFO - 'base_work_dir': '/builds/slave/test', 15:43:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:43:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:43:42 INFO - 'branch': 'Fx-Team-Non-PGO', 15:43:42 INFO - 'buildbot_json_path': 'buildprops.json', 15:43:42 INFO - 'config_files': ('talos/linux_config.py',), 15:43:42 INFO - 'default_actions': ('clobber', 15:43:42 INFO - 'read-buildbot-config', 15:43:42 INFO - 'download-and-extract', 15:43:42 INFO - 'populate-webroot', 15:43:42 INFO - 'create-virtualenv', 15:43:42 INFO - 'install', 15:43:42 INFO - 'run-tests'), 15:43:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:43:42 INFO - 'download_minidump_stackwalk': True, 15:43:42 INFO - 'download_symbols': 'ondemand', 15:43:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:43:42 INFO - 'tooltool.py': '/tools/tooltool.py', 15:43:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:43:42 INFO - '/tools/misc-python/virtualenv.py')}, 15:43:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:43:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:43:42 INFO - 'installer_path': 'installer.exe', 15:43:42 INFO - 'log_level': 'info', 15:43:42 INFO - 'log_name': 'talos', 15:43:42 INFO - 'log_to_console': True, 15:43:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:43:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:43:42 INFO - 'opt_config_files': (), 15:43:42 INFO - 'pip_index': False, 15:43:42 INFO - 'sps_profile': False, 15:43:42 INFO - 'sps_profile_interval': 0, 15:43:42 INFO - 'suite': 'dromaeojs', 15:43:42 INFO - 'system_bits': '32', 15:43:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:43:42 INFO - 'title': 'talos-linux64-ix-024', 15:43:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:43:42 INFO - 'use_talos_json': True, 15:43:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:43:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:43:42 INFO - 'work_dir': 'build'} 15:43:42 INFO - ##### 15:43:42 INFO - ##### Running clobber step. 15:43:42 INFO - ##### 15:43:42 INFO - Running pre-action listener: _resource_record_pre_action 15:43:42 INFO - Running main action method: clobber 15:43:42 INFO - rmtree: /builds/slave/test/build 15:43:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:43:43 INFO - Running post-action listener: _resource_record_post_action 15:43:43 INFO - ##### 15:43:43 INFO - ##### Running read-buildbot-config step. 15:43:43 INFO - ##### 15:43:43 INFO - Running pre-action listener: _resource_record_pre_action 15:43:43 INFO - Running main action method: read_buildbot_config 15:43:43 INFO - Using buildbot properties: 15:43:43 INFO - { 15:43:43 INFO - "project": "", 15:43:43 INFO - "product": "firefox", 15:43:43 INFO - "script_repo_revision": "production", 15:43:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:43:43 INFO - "repository": "", 15:43:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:43:43 INFO - "buildid": "20160323145252", 15:43:43 INFO - "pgo_build": "False", 15:43:43 INFO - "basedir": "/builds/slave/test", 15:43:43 INFO - "buildnumber": 1568, 15:43:43 INFO - "slavename": "talos-linux64-ix-024", 15:43:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:43:43 INFO - "platform": "ubuntu64_hw", 15:43:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:43:43 INFO - "branch": "fx-team", 15:43:43 INFO - "repo_path": "integration/fx-team", 15:43:43 INFO - "revision": "7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1", 15:43:43 INFO - "stage_platform": "linux64", 15:43:43 INFO - "builduid": "51edfbf8bcec4dc99eefaf57ef5ee958", 15:43:43 INFO - "slavebuilddir": "test" 15:43:43 INFO - } 15:43:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:43:43 INFO - Running post-action listener: _resource_record_post_action 15:43:43 INFO - ##### 15:43:43 INFO - ##### Running download-and-extract step. 15:43:43 INFO - ##### 15:43:43 INFO - Running pre-action listener: _resource_record_pre_action 15:43:43 INFO - Running main action method: download_and_extract 15:43:43 INFO - mkdir: /builds/slave/test/build/tests 15:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:43 INFO - https://queue.taskcluster.net/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:43:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:43:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:43:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:43:53 INFO - Downloaded 1361 bytes. 15:43:53 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:43:53 INFO - Using the following test package requirements: 15:43:53 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:43:53 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:43:53 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:43:53 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:53 INFO - u'jsshell-linux-x86_64.zip'], 15:43:53 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:43:53 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:43:53 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:43:53 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:43:53 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:43:53 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:43:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:53 INFO - https://queue.taskcluster.net/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:43:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:43:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:43:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:43:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:44:01 INFO - Downloaded 22063670 bytes. 15:44:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:44:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:44:02 INFO - Return code: 0 15:44:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:02 INFO - https://queue.taskcluster.net/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:44:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:44:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:44:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:44:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:44:07 INFO - Downloaded 22063670 bytes. 15:44:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:44:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:44:08 INFO - Return code: 0 15:44: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')]} 15:44:08 INFO - https://queue.taskcluster.net/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:44:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:44:13 INFO - Downloaded 10847187 bytes. 15:44:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:44:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:44:13 INFO - Return code: 0 15:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:13 INFO - https://queue.taskcluster.net/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:44:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:44:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:44:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:44:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:44:22 INFO - Downloaded 54263816 bytes. 15:44:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:44:22 INFO - mkdir: /builds/slave/test/properties 15:44:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:44:22 INFO - Writing to file /builds/slave/test/properties/build_url 15:44:22 INFO - Contents: 15:44:22 INFO - build_url:https://queue.taskcluster.net/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:44:23 INFO - Running post-action listener: _resource_record_post_action 15:44:23 INFO - Running post-action listener: set_extra_try_arguments 15:44:23 INFO - ##### 15:44:23 INFO - ##### Running populate-webroot step. 15:44:23 INFO - ##### 15:44:23 INFO - Running pre-action listener: _resource_record_pre_action 15:44:23 INFO - Running main action method: populate_webroot 15:44:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:44:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:44:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:44:23 INFO - '--tppagecycles', 15:44:23 INFO - '7'], 15:44:23 INFO - 'tests': ['tsvgm']}}, 15:44:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:44:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:44:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:44:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:44:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:44:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:44:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:23 INFO - 'talos_options': ['--e10s'], 15:44:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:23 INFO - 'tests': ['damp', 'tps']}, 15:44:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:23 INFO - 'talos_options': ['--e10s'], 15:44:23 INFO - 'tests': ['damp', 'tps']}, 15:44:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:44:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:44:23 INFO - 'other': {'tests': ['a11yr', 15:44:23 INFO - 'ts_paint', 15:44:23 INFO - 'tpaint', 15:44:23 INFO - 'sessionrestore', 15:44:23 INFO - 'sessionrestore_no_auto_restore', 15:44:23 INFO - 'tabpaint']}, 15:44:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:44:23 INFO - 'tests': ['a11yr', 15:44:23 INFO - 'ts_paint', 15:44:23 INFO - 'tpaint', 15:44:23 INFO - 'sessionrestore', 15:44:23 INFO - 'sessionrestore_no_auto_restore', 15:44:23 INFO - 'tabpaint']}, 15:44:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:44:23 INFO - 'tests': ['a11yr', 15:44:23 INFO - 'ts_paint', 15:44:23 INFO - 'tpaint', 15:44:23 INFO - 'sessionrestore', 15:44:23 INFO - 'sessionrestore_no_auto_restore', 15:44:23 INFO - 'tabpaint']}, 15:44:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:44:23 INFO - 'tests': ['a11yr', 15:44:23 INFO - 'ts_paint', 15:44:23 INFO - 'tpaint', 15:44:23 INFO - 'sessionrestore', 15:44:23 INFO - 'sessionrestore_no_auto_restore', 15:44:23 INFO - 'tabpaint']}, 15:44:23 INFO - 'other_l64': {'tests': ['a11yr', 15:44:23 INFO - 'ts_paint', 15:44:23 INFO - 'tpaint', 15:44:23 INFO - 'sessionrestore', 15:44:23 INFO - 'sessionrestore_no_auto_restore', 15:44:23 INFO - 'tabpaint']}, 15:44:23 INFO - 'other_nol64': {'tests': ['a11yr', 15:44:23 INFO - 'ts_paint', 15:44:23 INFO - 'tpaint', 15:44:23 INFO - 'sessionrestore', 15:44:23 INFO - 'sessionrestore_no_auto_restore', 15:44:23 INFO - 'tabpaint']}, 15:44:23 INFO - 'svgr': {'tests': ['tsvgx', 15:44:23 INFO - 'tsvgr_opacity', 15:44:23 INFO - 'tart', 15:44:23 INFO - 'tscrollx', 15:44:23 INFO - 'cart']}, 15:44:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:44:23 INFO - 'tests': ['tsvgx', 15:44:23 INFO - 'tsvgr_opacity', 15:44:23 INFO - 'tart', 15:44:23 INFO - 'tscrollx', 15:44:23 INFO - 'cart']}, 15:44:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:23 INFO - 'tests': ['tp5o']}, 15:44:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:23 INFO - 'talos_options': ['--e10s'], 15:44:23 INFO - 'tests': ['tp5o']}, 15:44:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:23 INFO - 'talos_options': ['--xperf_path', 15:44:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:23 INFO - 'tests': ['tp5n']}, 15:44:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:23 INFO - 'talos_options': ['--e10s', 15:44:23 INFO - '--xperf_path', 15:44:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:23 INFO - 'tests': ['tp5n']}}, 15:44:23 INFO - 'talos.zip': {'path': '', 15:44:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:44:23 INFO - Running post-action listener: _resource_record_post_action 15:44:23 INFO - ##### 15:44:23 INFO - ##### Running create-virtualenv step. 15:44:23 INFO - ##### 15:44:23 INFO - Running pre-action listener: _resource_record_pre_action 15:44:23 INFO - Running main action method: create_virtualenv 15:44:23 INFO - Creating virtualenv /builds/slave/test/build/venv 15:44:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:44:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:44:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:44:23 INFO - Using real prefix '/usr' 15:44:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:44:24 INFO - Installing distribute.............................................................................................................................................................................................done. 15:44:26 INFO - Installing pip.................done. 15:44:26 INFO - Return code: 0 15:44:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33b0fa4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd410>, '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 0x1cfe310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:44:26 INFO - Using env: {'DISPLAY': ':0', 15:44:26 INFO - 'HOME': '/home/cltbld', 15:44:26 INFO - 'LANG': 'en_US.UTF-8', 15:44:26 INFO - 'LANGUAGE': 'en_US:en', 15:44:26 INFO - 'LOGNAME': 'cltbld', 15:44:26 INFO - 'MAIL': '/var/mail/cltbld', 15:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:26 INFO - 'MOZ_NO_REMOTE': '1', 15:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:26 INFO - 'NO_EM_RESTART': '1', 15:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:26 INFO - 'PWD': '/builds/slave/test', 15:44:26 INFO - 'SHELL': '/bin/bash', 15:44:26 INFO - 'SHLVL': '1', 15:44:26 INFO - 'TERM': 'linux', 15:44:26 INFO - 'TMOUT': '86400', 15:44:26 INFO - 'USER': 'cltbld', 15:44:26 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 15:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:26 INFO - '_': '/tools/buildbot/bin/python'} 15:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:44:26 INFO - Cleaning up... 15:44:26 INFO - Return code: 0 15:44:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f33b0fa4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd410>, '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 0x1cfe310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:44:26 INFO - Using env: {'DISPLAY': ':0', 15:44:26 INFO - 'HOME': '/home/cltbld', 15:44:26 INFO - 'LANG': 'en_US.UTF-8', 15:44:26 INFO - 'LANGUAGE': 'en_US:en', 15:44:26 INFO - 'LOGNAME': 'cltbld', 15:44:26 INFO - 'MAIL': '/var/mail/cltbld', 15:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:26 INFO - 'MOZ_NO_REMOTE': '1', 15:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:26 INFO - 'NO_EM_RESTART': '1', 15:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:26 INFO - 'PWD': '/builds/slave/test', 15:44:26 INFO - 'SHELL': '/bin/bash', 15:44:26 INFO - 'SHLVL': '1', 15:44:26 INFO - 'TERM': 'linux', 15:44:26 INFO - 'TMOUT': '86400', 15:44:26 INFO - 'USER': 'cltbld', 15:44:26 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 15:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:26 INFO - '_': '/tools/buildbot/bin/python'} 15:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:26 INFO - Downloading/unpacking psutil>=0.7.1 15:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:32 INFO - Installing collected packages: psutil 15:44:32 INFO - Running setup.py install for psutil 15:44:32 INFO - building 'psutil._psutil_linux' extension 15:44:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:44:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:44:32 INFO - building 'psutil._psutil_posix' extension 15:44:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:44:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:32 INFO - Successfully installed psutil 15:44:32 INFO - Cleaning up... 15:44:32 INFO - Return code: 0 15:44:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:32 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 0x7f33b0fa4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd410>, '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 0x1cfe310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:32 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 15:44:32 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 15:44:32 INFO - Using env: {'DISPLAY': ':0', 15:44:32 INFO - 'HOME': '/home/cltbld', 15:44:32 INFO - 'LANG': 'en_US.UTF-8', 15:44:32 INFO - 'LANGUAGE': 'en_US:en', 15:44:32 INFO - 'LOGNAME': 'cltbld', 15:44:32 INFO - 'MAIL': '/var/mail/cltbld', 15:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:32 INFO - 'MOZ_NO_REMOTE': '1', 15:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:32 INFO - 'NO_EM_RESTART': '1', 15:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:32 INFO - 'PWD': '/builds/slave/test', 15:44:32 INFO - 'SHELL': '/bin/bash', 15:44:32 INFO - 'SHLVL': '1', 15:44:32 INFO - 'TERM': 'linux', 15:44:32 INFO - 'TMOUT': '86400', 15:44:32 INFO - 'USER': 'cltbld', 15:44:32 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 15:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:32 INFO - '_': '/tools/buildbot/bin/python'} 15:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:44:37 INFO - Installing collected packages: mozsystemmonitor 15:44:37 INFO - Running setup.py install for mozsystemmonitor 15:44:37 INFO - Successfully installed mozsystemmonitor 15:44:37 INFO - Cleaning up... 15:44:37 INFO - Return code: 0 15:44:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:37 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 0x7f33b0fa4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd410>, '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 0x1cfe310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:44:37 INFO - Using env: {'DISPLAY': ':0', 15:44:37 INFO - 'HOME': '/home/cltbld', 15:44:37 INFO - 'LANG': 'en_US.UTF-8', 15:44:37 INFO - 'LANGUAGE': 'en_US:en', 15:44:37 INFO - 'LOGNAME': 'cltbld', 15:44:37 INFO - 'MAIL': '/var/mail/cltbld', 15:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:37 INFO - 'MOZ_NO_REMOTE': '1', 15:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:37 INFO - 'NO_EM_RESTART': '1', 15:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:37 INFO - 'PWD': '/builds/slave/test', 15:44:37 INFO - 'SHELL': '/bin/bash', 15:44:37 INFO - 'SHLVL': '1', 15:44:37 INFO - 'TERM': 'linux', 15:44:37 INFO - 'TMOUT': '86400', 15:44:37 INFO - 'USER': 'cltbld', 15:44:37 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 15:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:37 INFO - '_': '/tools/buildbot/bin/python'} 15:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:44:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:44:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:43 INFO - Downloading docopt-0.6.1.tar.gz 15:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:44:43 INFO - Installing collected packages: blobuploader, requests, docopt 15:44:43 INFO - Running setup.py install for blobuploader 15:44:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:44:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:44:44 INFO - Running setup.py install for requests 15:44:44 INFO - Running setup.py install for docopt 15:44:44 INFO - Successfully installed blobuploader requests docopt 15:44:44 INFO - Cleaning up... 15:44:44 INFO - Return code: 0 15:44:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33b0fa4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd410>, '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 0x1cfe310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:44:44 INFO - Using env: {'DISPLAY': ':0', 15:44:44 INFO - 'HOME': '/home/cltbld', 15:44:44 INFO - 'LANG': 'en_US.UTF-8', 15:44:44 INFO - 'LANGUAGE': 'en_US:en', 15:44:44 INFO - 'LOGNAME': 'cltbld', 15:44:44 INFO - 'MAIL': '/var/mail/cltbld', 15:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:44 INFO - 'MOZ_NO_REMOTE': '1', 15:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:44 INFO - 'NO_EM_RESTART': '1', 15:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:44 INFO - 'PWD': '/builds/slave/test', 15:44:44 INFO - 'SHELL': '/bin/bash', 15:44:44 INFO - 'SHLVL': '1', 15:44:44 INFO - 'TERM': 'linux', 15:44:44 INFO - 'TMOUT': '86400', 15:44:44 INFO - 'USER': 'cltbld', 15:44:44 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 15:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:44 INFO - '_': '/tools/buildbot/bin/python'} 15:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:44 INFO - Running setup.py (path:/tmp/pip-oeKa9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:44 INFO - Running setup.py (path:/tmp/pip-AZrjIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:44 INFO - Running setup.py (path:/tmp/pip-_nEFXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:44 INFO - Running setup.py (path:/tmp/pip-dEyDoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:45 INFO - Running setup.py (path:/tmp/pip-x3yA5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:45 INFO - Running setup.py (path:/tmp/pip-iYKqYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:45 INFO - Running setup.py (path:/tmp/pip-WaP_Do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:45 INFO - Running setup.py (path:/tmp/pip-bASGSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:45 INFO - Running setup.py (path:/tmp/pip-Rzd1Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:45 INFO - Running setup.py (path:/tmp/pip-7L6TlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:45 INFO - Running setup.py (path:/tmp/pip-emJ_kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:45 INFO - Running setup.py (path:/tmp/pip-yEaqv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:45 INFO - Running setup.py (path:/tmp/pip-lnWm4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:45 INFO - Running setup.py (path:/tmp/pip-e44wSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:45 INFO - Running setup.py (path:/tmp/pip-9ZErCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:45 INFO - Running setup.py (path:/tmp/pip-0hhuWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:45 INFO - Running setup.py (path:/tmp/pip-N3UOGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:44:45 INFO - Running setup.py install for manifestparser 15:44:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:44:46 INFO - Running setup.py install for mozcrash 15:44:46 INFO - Running setup.py install for mozdebug 15:44:46 INFO - Running setup.py install for mozdevice 15:44:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:44:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:44:46 INFO - Running setup.py install for mozfile 15:44:46 INFO - Running setup.py install for mozhttpd 15:44:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:44:46 INFO - Running setup.py install for mozinfo 15:44:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:44:46 INFO - Running setup.py install for mozInstall 15:44:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:44:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:44:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:44:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:44:46 INFO - Running setup.py install for mozleak 15:44:46 INFO - Running setup.py install for mozlog 15:44:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:44:46 INFO - Running setup.py install for moznetwork 15:44:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:44:47 INFO - Running setup.py install for mozprocess 15:44:47 INFO - Running setup.py install for mozprofile 15:44:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:44:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:44:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:44:47 INFO - Running setup.py install for mozrunner 15:44:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:44:47 INFO - Running setup.py install for mozscreenshot 15:44:47 INFO - Running setup.py install for moztest 15:44:47 INFO - Running setup.py install for mozversion 15:44:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:44:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:44:47 INFO - Cleaning up... 15:44:47 INFO - Return code: 0 15:44:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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')]} 15:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33b0fa4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd410>, '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 0x1cfe310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:44:47 INFO - Using env: {'DISPLAY': ':0', 15:44:47 INFO - 'HOME': '/home/cltbld', 15:44:47 INFO - 'LANG': 'en_US.UTF-8', 15:44:47 INFO - 'LANGUAGE': 'en_US:en', 15:44:47 INFO - 'LOGNAME': 'cltbld', 15:44:47 INFO - 'MAIL': '/var/mail/cltbld', 15:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:47 INFO - 'MOZ_NO_REMOTE': '1', 15:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:47 INFO - 'NO_EM_RESTART': '1', 15:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:47 INFO - 'PWD': '/builds/slave/test', 15:44:47 INFO - 'SHELL': '/bin/bash', 15:44:47 INFO - 'SHLVL': '1', 15:44:47 INFO - 'TERM': 'linux', 15:44:47 INFO - 'TMOUT': '86400', 15:44:47 INFO - 'USER': 'cltbld', 15:44:47 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 15:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:47 INFO - '_': '/tools/buildbot/bin/python'} 15:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:47 INFO - Running setup.py (path:/tmp/pip-9WP28l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:48 INFO - Running setup.py (path:/tmp/pip-DW1WKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:48 INFO - Running setup.py (path:/tmp/pip-5d6KEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:48 INFO - Running setup.py (path:/tmp/pip-edbA53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:48 INFO - Running setup.py (path:/tmp/pip-MF_ZKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:48 INFO - Running setup.py (path:/tmp/pip-DRWUSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:48 INFO - Running setup.py (path:/tmp/pip-R88JB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:48 INFO - Running setup.py (path:/tmp/pip-61NYD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:48 INFO - Running setup.py (path:/tmp/pip-afXwEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:48 INFO - Running setup.py (path:/tmp/pip-kYCaOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:48 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)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:48 INFO - Running setup.py (path:/tmp/pip-YqBOHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:48 INFO - Running setup.py (path:/tmp/pip-OwwxBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:48 INFO - Running setup.py (path:/tmp/pip-q8zrwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:48 INFO - Running setup.py (path:/tmp/pip-zWIFKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:48 INFO - Running setup.py (path:/tmp/pip-qtbu_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:49 INFO - Running setup.py (path:/tmp/pip-6TUJrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:49 INFO - Running setup.py (path:/tmp/pip-Va7fdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:53 INFO - Downloading blessings-1.6.tar.gz 15:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:44:53 INFO - Installing collected packages: blessings 15:44:53 INFO - Running setup.py install for blessings 15:44:54 INFO - Successfully installed blessings 15:44:54 INFO - Cleaning up... 15:44:54 INFO - Return code: 0 15:44:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:44:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:54 INFO - Reading from file tmpfile_stdout 15:44:54 INFO - Current package versions: 15:44:54 INFO - argparse == 1.2.1 15:44:54 INFO - blessings == 1.6 15:44:54 INFO - blobuploader == 1.2.4 15:44:54 INFO - docopt == 0.6.1 15:44:54 INFO - manifestparser == 1.1 15:44:54 INFO - mozInstall == 1.12 15:44:54 INFO - mozcrash == 0.17 15:44:54 INFO - mozdebug == 0.1 15:44:54 INFO - mozdevice == 0.48 15:44:54 INFO - mozfile == 1.2 15:44:54 INFO - mozhttpd == 0.7 15:44:54 INFO - mozinfo == 0.9 15:44:54 INFO - mozleak == 0.1 15:44:54 INFO - mozlog == 3.1 15:44:54 INFO - moznetwork == 0.27 15:44:54 INFO - mozprocess == 0.22 15:44:54 INFO - mozprofile == 0.28 15:44:54 INFO - mozrunner == 6.11 15:44:54 INFO - mozscreenshot == 0.1 15:44:54 INFO - mozsystemmonitor == 0.0 15:44:54 INFO - moztest == 0.7 15:44:54 INFO - mozversion == 1.4 15:44:54 INFO - psutil == 3.1.1 15:44:54 INFO - requests == 1.2.3 15:44:54 INFO - wsgiref == 0.1.2 15:44:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:54 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 0x7f33b0fa4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd410>, '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 0x1cfe310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:44:54 INFO - Using env: {'DISPLAY': ':0', 15:44:54 INFO - 'HOME': '/home/cltbld', 15:44:54 INFO - 'LANG': 'en_US.UTF-8', 15:44:54 INFO - 'LANGUAGE': 'en_US:en', 15:44:54 INFO - 'LOGNAME': 'cltbld', 15:44:54 INFO - 'MAIL': '/var/mail/cltbld', 15:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:54 INFO - 'MOZ_NO_REMOTE': '1', 15:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:54 INFO - 'NO_EM_RESTART': '1', 15:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:54 INFO - 'PWD': '/builds/slave/test', 15:44:54 INFO - 'SHELL': '/bin/bash', 15:44:54 INFO - 'SHLVL': '1', 15:44:54 INFO - 'TERM': 'linux', 15:44:54 INFO - 'TMOUT': '86400', 15:44:54 INFO - 'USER': 'cltbld', 15:44:54 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 15:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:54 INFO - '_': '/tools/buildbot/bin/python'} 15:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:44:54 INFO - Cleaning up... 15:44:54 INFO - Return code: 0 15:44:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33b0fa4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd410>, '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 0x1cfe310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44: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', 'jsonschema'] in /builds/slave/test/build 15:44: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 jsonschema 15:44:54 INFO - Using env: {'DISPLAY': ':0', 15:44:54 INFO - 'HOME': '/home/cltbld', 15:44:54 INFO - 'LANG': 'en_US.UTF-8', 15:44:54 INFO - 'LANGUAGE': 'en_US:en', 15:44:54 INFO - 'LOGNAME': 'cltbld', 15:44:54 INFO - 'MAIL': '/var/mail/cltbld', 15:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:54 INFO - 'MOZ_NO_REMOTE': '1', 15:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:54 INFO - 'NO_EM_RESTART': '1', 15:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:54 INFO - 'PWD': '/builds/slave/test', 15:44:54 INFO - 'SHELL': '/bin/bash', 15:44:54 INFO - 'SHLVL': '1', 15:44:54 INFO - 'TERM': 'linux', 15:44:54 INFO - 'TMOUT': '86400', 15:44:54 INFO - 'USER': 'cltbld', 15:44:54 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 15:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:54 INFO - '_': '/tools/buildbot/bin/python'} 15:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:54 INFO - Downloading/unpacking jsonschema 15:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:44:59 INFO - Downloading/unpacking functools32 (from jsonschema) 15:44: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 15:44: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 15:44: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 15:44: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 15:44: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 15:44: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 15:44:59 INFO - Downloading functools32-3.2.3-2.tar.gz 15:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:44:59 INFO - warning: no files found matching '*.txt' 15:44:59 INFO - no previously-included directories found matching 'build' 15:44:59 INFO - no previously-included directories found matching 'dist' 15:44:59 INFO - no previously-included directories found matching '.git*' 15:44:59 INFO - Installing collected packages: jsonschema, functools32 15:44:59 INFO - Running setup.py install for functools32 15:44:59 INFO - warning: no files found matching '*.txt' 15:44:59 INFO - no previously-included directories found matching 'build' 15:44:59 INFO - no previously-included directories found matching 'dist' 15:44:59 INFO - no previously-included directories found matching '.git*' 15:44:59 INFO - Successfully installed jsonschema functools32 15:44:59 INFO - Cleaning up... 15:44:59 INFO - Return code: 0 15:44:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 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 0x7f33b0fa4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd410>, '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 0x1cfe310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:44:59 INFO - Using env: {'DISPLAY': ':0', 15:44:59 INFO - 'HOME': '/home/cltbld', 15:44:59 INFO - 'LANG': 'en_US.UTF-8', 15:44:59 INFO - 'LANGUAGE': 'en_US:en', 15:44:59 INFO - 'LOGNAME': 'cltbld', 15:44:59 INFO - 'MAIL': '/var/mail/cltbld', 15:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:59 INFO - 'MOZ_NO_REMOTE': '1', 15:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:59 INFO - 'NO_EM_RESTART': '1', 15:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:59 INFO - 'PWD': '/builds/slave/test', 15:44:59 INFO - 'SHELL': '/bin/bash', 15:44:59 INFO - 'SHLVL': '1', 15:44:59 INFO - 'TERM': 'linux', 15:44:59 INFO - 'TMOUT': '86400', 15:44:59 INFO - 'USER': 'cltbld', 15:44:59 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 15:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:59 INFO - '_': '/tools/buildbot/bin/python'} 15:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:59 INFO - Downloading/unpacking flake8 15:44: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 15:44: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 15:44: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 15:44: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 15:44: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 15:44: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 15:45:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:45:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:45:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:45:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:05 INFO - no previously-included directories found matching 'docs/_build' 15:45:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:45:05 INFO - Running setup.py install for pep8 15:45:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:05 INFO - no previously-included directories found matching 'docs/_build' 15:45:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:45:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:45:05 INFO - Cleaning up... 15:45:05 INFO - Return code: 0 15:45:05 INFO - Running post-action listener: _resource_record_post_action 15:45:05 INFO - Running post-action listener: _start_resource_monitoring 15:45:05 INFO - Starting resource monitoring. 15:45:05 INFO - ##### 15:45:05 INFO - ##### Running install step. 15:45:05 INFO - ##### 15:45:05 INFO - Running pre-action listener: _resource_record_pre_action 15:45:05 INFO - Running main action method: install 15:45:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:05 INFO - Reading from file tmpfile_stdout 15:45:05 INFO - Detecting whether we're running mozinstall >=1.0... 15:45:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:45:06 INFO - Reading from file tmpfile_stdout 15:45:06 INFO - Output received: 15:45:06 INFO - Usage: mozinstall [options] installer 15:45:06 INFO - Options: 15:45:06 INFO - -h, --help show this help message and exit 15:45:06 INFO - -d DEST, --destination=DEST 15:45:06 INFO - Directory to install application into. [default: 15:45:06 INFO - "/builds/slave/test"] 15:45:06 INFO - --app=APP Application being installed. [default: firefox] 15:45:06 INFO - mkdir: /builds/slave/test/build/application 15:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:45:21 INFO - Reading from file tmpfile_stdout 15:45:21 INFO - Output received: 15:45:21 INFO - /builds/slave/test/build/application/firefox/firefox 15:45:21 INFO - Running post-action listener: _resource_record_post_action 15:45:21 INFO - ##### 15:45:21 INFO - ##### Running run-tests step. 15:45:21 INFO - ##### 15:45:21 INFO - Running pre-action listener: _resource_record_pre_action 15:45:21 INFO - Running main action method: run_tests 15:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:45:21 INFO - Python 2.7.3 15:45:21 INFO - Return code: 0 15:45:21 INFO - grabbing minidump binary from tooltool 15:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:21 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 0x1cfd410>, '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 0x1cfe310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:45:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:45:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:45:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:45:21 INFO - Return code: 0 15:45:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:45:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:45:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:45:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:45:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:45:22 INFO - Return code: 0 15:45:22 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/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 15:45:22 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/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 15:45:22 INFO - Using env: {'DISPLAY': ':0', 15:45:22 INFO - 'HOME': '/home/cltbld', 15:45:22 INFO - 'LANG': 'en_US.UTF-8', 15:45:22 INFO - 'LANGUAGE': 'en_US:en', 15:45:22 INFO - 'LOGNAME': 'cltbld', 15:45:22 INFO - 'MAIL': '/var/mail/cltbld', 15:45:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:45:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:22 INFO - 'MOZ_NO_REMOTE': '1', 15:45:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:22 INFO - 'NO_EM_RESTART': '1', 15:45:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:22 INFO - 'PWD': '/builds/slave/test', 15:45:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:45:22 INFO - 'SHELL': '/bin/bash', 15:45:22 INFO - 'SHLVL': '1', 15:45:22 INFO - 'TERM': 'linux', 15:45:22 INFO - 'TMOUT': '86400', 15:45:22 INFO - 'USER': 'cltbld', 15:45:22 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229', 15:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:22 INFO - '_': '/tools/buildbot/bin/python'} 15:45:22 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/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 15:45:22 INFO - mozversion application_buildid: 20160323145252 15:45:22 INFO - mozversion application_changeset: 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 15:45:22 INFO - mozversion application_display_name: Nightly 15:45:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:45:22 INFO - mozversion application_name: Firefox 15:45:22 INFO - mozversion application_remotingname: firefox 15:45:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:45:22 INFO - mozversion application_vendor: Mozilla 15:45:22 INFO - mozversion application_version: 48.0a1 15:45:22 INFO - mozversion platform_buildid: 20160323145252 15:45:22 INFO - mozversion platform_changeset: 7b0bb5c3ab01ab5003c64d2c715742db93eb9fd1 15:45:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:45:22 INFO - mozversion platform_version: 48.0a1 15:45:22 INFO - using testdate: 1458773122 15:45:22 INFO - actual date: 1458773122 15:45:22 INFO - starting webserver on 'localhost:50976' 15:45:22 INFO - SUITE-START | Running 2 tests 15:45:22 INFO - TEST-START | dromaeo_css 15:45:22 INFO - operating with platform_type : linux_ 15:45:22 INFO - Initialising browser for dromaeo_css test... 15:45:22 INFO - TEST-INFO | started process 22142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpps_Isi/profile http://localhost:50976/getInfo.html) 15:45:27 INFO - PROCESS | 22142 | __metrics Screen width/height:1600/1200 15:45:27 INFO - PROCESS | 22142 | colorDepth:24 15:45:27 INFO - PROCESS | 22142 | Browser inner width/height: 1024/697 15:45:27 INFO - PROCESS | 22142 | __metrics 15:45:27 ERROR - PROCESS | 22142 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:45:28 INFO - TEST-INFO | 22142: exit 0 15:45:28 INFO - Browser initialized. 15:45:28 INFO - Running cycle 1/1 for dromaeo_css test... 15:45:28 INFO - TEST-INFO | started process 22234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpps_Isi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:40 INFO - PROCESS | 22234 | RSS: Main: 158142464 15:45:40 INFO - PROCESS | 22234 | 15:46:31 INFO - PROCESS | 22234 | 1458773191699 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:48:42 INFO - PROCESS | 22234 | Cycle 1(1): loaded http://localhost:50976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50976/tests/dromaeo/cssquery-ext.html) 15:48:43 INFO - PROCESS | 22234 | RSS: Main: 242016256 15:48:43 INFO - PROCESS | 22234 | 15:51:46 INFO - PROCESS | 22234 | Cycle 1(1): loaded http://localhost:50976/tests/dromaeo/cssquery-ext.html (next: http://localhost:50976/tests/dromaeo/cssquery-jquery.html) 15:51:46 INFO - PROCESS | 22234 | RSS: Main: 235819008 15:51:46 INFO - PROCESS | 22234 | 15:54:48 INFO - PROCESS | 22234 | Cycle 1(1): loaded http://localhost:50976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50976/tests/dromaeo/cssquery-mootools.html) 15:54:49 INFO - PROCESS | 22234 | RSS: Main: 242597888 15:54:49 INFO - PROCESS | 22234 | 15:57:51 INFO - PROCESS | 22234 | Cycle 1(1): loaded http://localhost:50976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50976/tests/dromaeo/cssquery-prototype.html) 15:57:51 INFO - PROCESS | 22234 | RSS: Main: 205406208 15:57:51 INFO - PROCESS | 22234 | 16:00:54 INFO - PROCESS | 22234 | Cycle 1(1): loaded http://localhost:50976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50976/tests/dromaeo/cssquery-yui.html) 16:00:54 INFO - PROCESS | 22234 | RSS: Main: 200781824 16:00:54 INFO - PROCESS | 22234 | 16:03:57 INFO - PROCESS | 22234 | Cycle 1(1): loaded http://localhost:50976/tests/dromaeo/cssquery-yui.html (next: http://localhost:50976/tests/dromaeo/cssquery-dojo.html) 16:03:57 INFO - PROCESS | 22234 | RSS: Main: 272404480 16:03:57 INFO - PROCESS | 22234 | 16:03:57 INFO - PROCESS | 22234 | __start_tp_report 16:03:57 INFO - PROCESS | 22234 | _x_x_mozilla_page_load 16:03:57 INFO - PROCESS | 22234 | _x_x_mozilla_page_load_details 16:03:57 INFO - PROCESS | 22234 | |i|pagename|runs| 16:03:57 INFO - PROCESS | 22234 | |0;dojo.html;2554.3486410965206;2616.123598594471;2629.1586692258484;2638.4591158812445;2651.642028326176;4411.977940110303;4505.819767209307;4520.028193938307;4545.136424079426;4549.613282870956;4487.775611219442;4531.071130418264;4536.7051141675765;4581.083783243348;4611.677182597219;4147.129102888382;4151.8962025949295;4166.7708276044805;4197.349410841324;4277.935830962538;4226.218149642326;4240.893977650552;4256.936145957813;4283.593058659422;4299.677524185683;4172.91654166918;4174.979125104355;4192.035831758697;4267.338562522814;4268.423762792015;4198.538160802309;4201.2017716634045;4211.241976444238;4233.343831706091;4239.682023848193;4153.501579810412;4182.498100227962;4196.685248606367;4229.344451610005;4241.59704828044;4422.29243321067;4494.258447356182;4524.411826462571;4531.252343363374;4546.499885012646;4817.181079216542;4826.155422800995;4835.202191638376;4840.394950631171;4848.830290939835;4861;4862.78117484714;4864.318995340655;4865.610751139936;4866.172750632401;4554.681172317939;4602.125596136723;4603.815847366068;4645.094206629708;4653.860384188446;5024.171011783015;5053.772580233898;5055.545000949932;5057.494250574987;5106.361704786902;4658.394408726844;4790.8323208687525;4792.784324705397;4829.9034019319415;4851.56335929768;4908.558229759267;4911.214205727067;4925.950740492621;4933.28467372229;4988.226824842155;4825.8121123895635;4898.559129678346;4905.901881962341;4910.48439913811;4946.431160416598;4744.217204161275;4760.64295177863;4791.592714619227;4888.26675998596;4916.532929371704;4098.118904435561;4099.938500922489;4105.4252404663375;4129.669626429938;4144.772037537964;3593.4250519916686;3604.4953706481115;3605.9278814423565;3631.7276204284785;3645.434957581579;4173.728707633994;4246.44796176495;4256.2764330063965;4298.871033868989;4327.6970612057485;4910.90178196434;4955.876103097379;4957.925631115536;4966.304717339575;4978.925316120261;4232.640225580799;4265.296226122717;4267.615914567704;4295.5060168080445;4314.71954322968;4324.2648749712625;4384.473863136444;4403.251447253974;4453.532379100147;4465.486469056035;4632.698874573142;4648.814047438133;4652.255639097728;4654.650901182493;4679.181143299909;4854.902901942012;4874.975625121993;4899.191633380452;4906.215005599087;4906.754662266943;4607.976960115178;4636.83771068011;4649;4659.5573420525;4687.695299805502;4830.734309613005;4841.080194762983;4857.174280372275;4864.586510146677;4903.04390643821;4806.399200099988;4919.508049195052;4921.212605983025;4926.5073492650445;4969.552740253394;4749.976250118727;4796.616270698406;4797.208460603962;4814.374131362901;4843.24929635907;4756.643251756063;4782.665213435026;4788.353572267839;4798.424189097331;4842.757862106951;4637.536246375335;4686;4723.574878260973;4738.241881298975;4783.808647654194;4735.313379560013;4760.190767569591;4797.232442809134;4806.279058141306;4820.517948205292;4679.532046795293;4681.742504162304;4682.484926657997;4686.086213188396;4733.36099626546 16:03:57 INFO - PROCESS | 22234 | |1;ext.html;486.57667828988787;528.2182370092263;528.7541293298615;532.8348212054264;547.2420697334192;27071.45857082857;35135.82432087839;35526.82236588813;35616.28767424657;35721.82139089308;37990.24019519608;38555.228895422144;38556.614433855655;38557.8072109639;38651.613483865156;7148.392386647141;7316.341529262365;7685.807854803633;7869.173736757644;7873.842523149562;9981.351212171221;10249.128824049927;10254.487275636226;10256.179505639531;10258.743531411737;9947.950260248688;10054.748631284203;10055.396676199414;10057.748556286115;10074;9817.754556136118;9897.505124743733;9898.059684329977;9911.801763964717;9916.057974492413;9717.174040206592;9830.262730295257;9846.753831154207;9858.457784821832;9860.60557577696;39415.80292098521;40110.79944600288;40269.19461610781;40331.7983410084;40442.59557404418;3223.8065716056876;3233.7413006959387;3578.2127931854952;3829.5596006459336;3879.903002424962;27665.446691066267;27942.580861287097;28232.717672823215;29281.414371712446;29309.70690293091;3479.3389256041273;3504.2991401719505;3584.032311275967;3589.730770192246;3610.7291953103622;256078;258558;258629;259462.9999999981;260106;45421.318680219825;63691.68154159292;64382.356176438574;64418;64483.677581611795;46020;46097.7695111529;46514.76742616265;46540.301895471595;46617;13843.238621875693;14222.146671199554;14256;14264.928675356765;14269.286535673382;11180.888191118147;11260.493277802518;11263.211575189658;11362.375069371265;11381.260218085798;15539.21299050601;15640.765388519181;15724.371025159095;15753.739700823906;15781.921090394475;6267.96866015667;6294.464970477561;6322.462590679844;6326.810195694136;6488;910.4355299714219;943.698016634684;970.6748239339901;1019.3293570844435;1032.667858462575;28266.576001359997;28346.77157324869;28429.289267768057;28668.71331286702;28980.565291520645;1037.911777498921;1039.5477967084344;1078.8344610550585;1092.4046394714899;1157.6353448663813;14282.143071415749;14825;14869.702605947821;14973.550793476214;15080.472183473526;299999;301846;303436;304354;304933;49754.751226243636;50268;50313;50388;50442.747786260836;1213.969650758738;1254.7553227120625;1254.8494180698374;1256.0956111599633;1265.7848165811833;26564.867175664;27877.16368508948;27948.72051279461;28298.71701282961;28382.148535543965;44542.3318650227;44585.10829783451;44776;44962.3255651159;45005.774971124934;232262;232530;233203;233484;234205;27204.72795272022;27776.44447111087;32736.181595460304;33239.33521329608;33642.66357336493;37559.62440375561;37624.62375376211;37873.62126378701;37894.431583525715;45214;32176.678233217368;32917;33289.500657490644;33569.83215083909;34029.31941361209;32899;33202;33280.50079248765;33444.33111337711;33592.32815343728;28498.715012850436;31681.5247771279;32830.507542386404;35752;35991.64008359883;27735.63597477498;30709.539356909216;33817.32365352728;35614.64385356217;35691;23541.764582353957;23563.764362356844;23645.527089458457;23795.286141415785;23950.281491554586 16:03:57 INFO - PROCESS | 22234 | |2;jquery.html;343.6958291911657;348.59388812033967;361.199942128186;366.4887481962662;368.83402468889005;12092.093093018015;16285.83714162858;16797.91601041993;16869.578260543494;17296.56758581036;16606.916965415156;16683.666326673458;17038.148092595384;17098.914505427485;17263;4917.09033828741;5071.391433028042;5116.846494605168;5129.102407078765;5150.819721309755;5048.823291184809;5124.128898087334;5142.588592912558;5143.4599367066485;5170.172772356424;5124.436312005676;5136.820211292606;5137.049645815518;5138.049460849736;5139.845804625848;4879.6828206166665;5035.77339019745;5040.16837221858;5052.469490703478;5120.820771273006;4480.8879778005485;4510.774461276923;4516.345129956171;4518.299663552155;4518.841840535565;19136.904315478474;20080.69878951817;20107;20214.898925505426;20258.49353766153;2049.252023011605;2072.89635518225;2082.4506925718683;2084.833213342929;2559.436923876744;11286.604968826052;13011.544595939096;13019.479220831156;13436.395362208725;13466.663333416744;1813.6372725454962;1840.1719226348198;1870.560418301698;1933.825955663997;1955.8533110016806;55945;58163.70918145382;58620;58931.70534147345;59763.701181493816;9074.500902450429;9791.216702663769;9956.303058785816;10238.641647542448;10398.480075996169;12303.138780285473;12825.551105711254;12830.486780528861;12839.101262911694;12849.678758030937;7004.789856304319;7160.534565253346;7307.7807665770115;7430.034095567649;7464.440166987498;7132.1441427029085;7212.472727091975;7276.417886569062;7328.193898671142;7332.41340692754;6160.44555989963;6297.748090076346;6303.621782693053;6310.684465776692;6335.11308416822;1654.8924319919167;1716.262007336857;1776.6091459878805;1828.1225011994318;1850.4911149433744;852.9189726975927;898.820235952812;926.4487629860222;995.2635050063046;1017.0947856407803;17307.134643267786;17423.825761742475;17535.210915508833;18007.279708811762;18073.36743213981;868.6438560190292;902.3412908576645;917.3532659475054;920.3787443475761;936.5972631768406;7255.709771609077;10052;10259.692209233735;10356.533955972;10500.212484063573;241348;244234;421734;423654;427069;74772.62613686897;75191.62404188054;75621;75804.62097689476;77841;987.0672214757129;998.8202123617818;1009.3136667066318;1017.4912543728136;1021.2340744441668;15007.399704012154;15209.543713688607;15216.771748424004;15395.384184632938;15692.607684807972;31971;33795.32409351848;34101.65898340985;34234.48648270228;34444.82777586096;43672.56327436685;47025.529744702115;47108.29337560008;47119.52880471152;47607;7212.783616491513;7396.741114060982;7475.289847464483;7557.5465472071855;7706.383489320953;9452.858207127036;10862.945685271523;11214.887851121384;11515.884841151481;11549.307041577533;9730;9873.95063024709;10083.949580252345;10100.747481313027;10565.471726413802;10135.847962280719;10196.388216706724;10258.333208341433;10290;10317.690469285933;10201.948990255001;10649.787004260026;10848.566057357617;10969.122470202205;11023.669289921316;7455.366293865082;7473.40212782987;7508.774736757906;7638.50349727266;7798.805029874072;9666.420014799134;10497.42264175447;10607.734806629896;10755;10827.350358978487 16:03:57 INFO - PROCESS | 22234 | |3;mootools.html;1260.4643026713645;1452.5279284232624;1465.0916431812275;1622.1321592947768;1770.442310672138;7255.310745479178;7462.067241594801;7483.73806916758;7491.288327608882;7495;7081.362677359037;7225.530340527862;7225.819354516139;7248.456365772562;7276;1951.4243298226986;2177.7277840269967;2220.877851718159;2225.4658881868395;2247.4606094537276;2191.901364438604;2202.757696653367;2202.7907348801837;2203.151786562177;2203.724534433196;2117.089651449876;2261.9208327708534;2265.2184996176293;2266.6260067088992;2267.0818318581;2245.36007237938;2271.2731925783755;2276.3057267533395;2297.7242730872235;2297.7587353327826;2213.4134454369605;2228.3649159989327;2244.932652020442;2248.303026061926;2294.804941579968;7614.276643718893;7660.310572048486;7662.310392064685;7674;7694.538327700356;4553.5674110959735;4680.602148817355;4706.458757242926;4712.95287047132;4722.315264286659;2983.4033193361197;3102.069379186235;3115.8442077896016;3144.701253380925;3160.747140228776;931.8043210925714;935.242453612576;941.3410612571228;996.1632228927735;999.8400255959084;10093.89906100937;10165.491725413774;10171.643992460302;10193.541290641939;10216.233782466345;4018.3771515415156;4186.665066794649;4219.767912764766;4325.76208308546;4327.091310824699;8271.751847444586;8314.792130196793;8317.584120793936;8356.289715374262;8382.538960357238;4133.0700592367075;4631.930521042187;4639.048994956026;4640.976795116003;4678.976605117021;4123.711340206157;4210.368444733314;4212.241796476664;4219.177260434186;4252.043290259729;3247.366763481146;3334.566506354207;3356.3622911646708;3387.187075102007;3396.9490457643155;1026.081656917055;1031.2523420520063;1031.510032734445;1032.5766435761302;1089.0144419300545;1169.6198735411026;1196.646989138189;1201.4293210724836;1210.5581462766204;1239.863615002349;7192.244814294424;7299.927000730031;7328.633568321563;7353.779386618303;7357.668904899292;452.8596135198033;464.2409660205521;466.0446085524661;468.67192964924686;468.9624830013591;5597.552195824324;5647.887042259132;5656.208130861683;5659.886802263932;5691.630044047124;9169.541522923828;9312.255019598417;9343.813123737624;9397.201237894855;9549.379290346105;9261.536923153815;9304.395214311047;9304.906950930404;9357.859632105525;9395.765105872271;7117.6085315308155;7221.169565499929;7337.74317898871;7347.88978165328;7356.448266379936;6915.792526224222;6942.791716248521;6962.512624116466;6983.790486285419;7009.3691567757105;8177.550234736908;8373.162683731578;8493.873459637802;8563.700270490503;8576.785580360542;8628.266597339296;8788.516631585324;8834.823303534022;8846.690365837165;8864.556772161237;5917.763289468545;6298.590591611531;6425.421712045938;6447.4197322241225;6616.603003819786;7150.64246787669;7164.462665300019;7197.388222001188;7220.025296585104;7225.349718525358;6350.650714210578;6401.103845461732;6434.485241180788;6452.903206451813;6453.870922581616;6378.90431643535;6422.293547709654;6459.483241340776;6525;6529.9020514691365;6729.495287853332;6760.357766012221;6777.152855893013;6840.692168852314;6852.211995620568;5977.103434484862;6010.639361638316;6041.395860413923;6123.540734444845;6130;6342.809715708536;6348.047792831112;6370.490360771035;6393.744250230125;6402.199725034371 16:03:57 INFO - PROCESS | 22234 | |4;prototype.html;318.78800597602594;320.624868903383;323.6068177164745;325.7068638225595;328.95723555937724;5267.157254839227;5271.472852714726;5277.920831187535;5282.89434211316;5397.379301380342;5288.127458969266;5313.57491400688;5318.654287471311;5322.121849894773;5323.8136665216725;3931.174453364797;4019.7387169834014;4082.5509193988637;4121.155163191554;4139.3997870308785;4059.2490389278078;4089.3048181809163;4089.8568550100754;4096.426500289962;4131.876043718678;4086.5300490443533;4090.8159132839096;4092.1611069730634;4102.8974275643195;4118.341065429532;3926.293267211915;4027.7583344999393;4109.4246805447265;4113.814878330452;4115.506139263278;3620.2035552178477;3630;3636.1455058061333;3643.5809881863397;3646.2342907989355;5048.495150484959;5056.115179843513;5068.037072956126;5071.137906555894;5079.212722028092;4751.073540659573;4753.572178503951;4754.02542478791;4758.405199350082;4763.118823017753;5573.27547418837;5577.776888924438;5581.134924086773;5581.386047534768;5585.664860108406;4004.83980640774;4007.1184339445276;4008.819603117867;4011.859584914514;4015.598440155961;5618.803341883015;5802.477777000048;5808.12878068289;5846.561507886926;5916.4379383958885;3897.713754461021;3922.5685174630767;3924.6860251179837;3929.410588411704;3934.429507721364;3971.860984865516;3981.0843505993785;3982.9203415932097;3985.143194213258;3986.481757371523;4609.331646911179;4610.76946152691;4614.492405835355;4615.930761038587;4616.3306320584;5606.831795046155;5615.943840561624;5619.578531610146;5620.85947851307;5624.803131890364;1407.3174510362467;1423.1745587559192;1424.608232736006;1424.8076509671062;1426.8359138698975;903.2638399704351;932.4125800745622;941.223490620241;946.1910066892846;966.087047739879;4840.588549973291;4843.733594652328;4848.442429120626;4863.392075990501;4867.6836005660225;5715.5427565794635;5719.7712091516705;5754.108113242454;5781.624194427349;5787.594868359174;4847.175980083394;4848.151573474628;4855.562999330006;4857.9028419432125;4873.512648735169;3061.3265081681993;3090.6909309068915;3097.241175911916;3098.10155055036;3098.194469437917;5395.676259424368;5422.3764267109;5423.129020487925;5438.945610543923;5444.156155795858;5722.856928576819;5865.853353666107;5884.293884733774;5892.499137573354;5899.380565040609;5399.37907140676;5414.458554144554;5423.186522021729;5432.13085906261;5434.91847622286;5735.655860648374;5736.770529178953;5739.253896993364;5748.5688573358;5750;5619.550435965031;5623;5626.690532020778;5631.493165615114;5632.2678051853;5417.322834645669;5427.213054107211;5427.511523962862;5429.7556609953435;5431.864203394789;3857.517810273716;3987.0829709167633;4008.3586626139677;4020.2361551306326;4037.051292946214;5778.768849245983;5792.5655575832825;5798.6810725410505;5800.912986305125;5807.274090738658;5586.804461843816;5595.832125036255;5601.159826026129;5602.523785478117;5602.66384016944;5580.190872323572;5586.636868603528;5587.888242235052;5595.692236927008;5597.328320601554;5486.149646804752;5500.614956953135;5506.174073888948;5509.614326997072;5510.118381059011;5465.754041068241;5686.545076393962;5696.259486266758;5696.772129114789;5697.658140511582;5521.089020311603;5538.750756215899;5555.2778138841695;5560.165975103605;5561.360443549043 16:03:57 INFO - PROCESS | 22234 | |5;yui.html;668.4485299627805;702.9121359830021;711.8647456983173;726.7492715013321;742.7387126523407;12476.563320283793;12485.25088494691;12555;12663.3035183065;12687.746245075094;12212.572559960403;12268.01855851532;12273.815892761593;12283.14018018739;12285;691.3086913086913;702.3783951203171;704.1303989572873;705.0587465733227;706.1067749297143;654.3750718064261;794.9085855126648;805.4120492040814;813.1786895235825;816.4733746733353;847.3348421489133;849.0617867256685;849.8257857139303;850.8893843800297;850.9489430634151;844.5903736687701;846.949183049019;847.8897743293394;847.9024912135121;848.240824462106;500.0598874116674;613.4325748682451;619.5632079384023;623.0187454758773;623.9376062393725;11876.228045177037;11916.702082447922;11933.34366609836;11949.402529873472;11950.880491195063;12053.758924821543;12356.752864942651;12559.120861539695;12686.238825670489;12722.363881805873;9916.256280778898;9926.106650401498;10007;10017.499125043792;10121;3297.3240485700376;3306.2560923792194;3345.414552453311;3430.5025771263026;3438.3123375325035;40216.59783402158;40566;40680.982975425555;40744.38883416751;40812.183756325;8810.823783524422;8958.86561701575;8963.148500892405;9037.909620903838;9064.138906803842;17614.735778963324;17720.113994300234;17835.197416116305;17879.10604469797;17913.19390627425;6724.125863637793;6837.247902730695;6839.521233513607;6882.483813713891;6927.826804329932;3758.9629895939574;3791;3819.3698039823116;3863.111484358557;3887.1253967857006;2942.838143902106;2961.8815247390294;2963.881444742186;2964.777641676883;2965.1697524693122;495.7620342235747;496.3473032961644;502.5828562293288;517.3119750731518;517.8394697643743;552.7678375082475;584.2871696530226;625.7309356976543;637.9075034120027;639.2424976402978;7953.085395179628;8143.267105960492;8156.5513896735065;8328.500289982621;8358.916410835935;621.4313902778997;625.565232163651;628.6416742456847;629.2291942370559;631.9842003949846;3705.5368078990127;3747.7938713371027;3823.5411750590106;3832.5400951885395;3878.2825177342283;48638.5136148634;50379;50697.74651126794;51196;51231;44349;44383.77808110939;45281;45341.77329113399;46406.30390544145;41191.588084118775;41637;42145.578544214775;42613.14773704509;42901.35647965283;7519.135299440634;7706.730264440717;7805.960970195113;7870;7891;32296.35407291888;32297.35405291928;32568.67431325751;32893.34213315672;33104.1723956903;37846.43230351492;37888.62111378851;38567.228655426174;42221.577784221765;42391.15217695691;9610.375325603813;9646.728962637228;9651.613935442503;9810.950945245228;9914.652987145415;10434.791304174027;10482.947585262025;10494.580216791242;10560.471976400995;10721;9760.951195243979;9762.46306453152;9828.655997040069;10207.387556746618;10330.535125919201;9873.40759554429;9980.600775969171;10121.797564048826;10349.27555071168;10396.532156052845;9485.430874147572;9881.357711748713;9914.603415863285;10217.693469195936;10244.846327304947;7940.841183176189;7972.832130693019;8049.637766300648;8095.757127286191;8316.750497485085;8117.715879944174;8252.422330436812;8471.830563388821;8676.869846952175;8709.695160669346 16:03:57 INFO - PROCESS | 22234 | __end_tp_report 16:03:57 INFO - PROCESS | 22234 | __start_cc_report 16:03:57 INFO - PROCESS | 22234 | _x_x_mozilla_cycle_collect,828 16:03:57 INFO - PROCESS | 22234 | __end_cc_report 16:03:57 INFO - PROCESS | 22234 | __startTimestamp1458774237705__endTimestamp 16:03:57 INFO - PROCESS | 22234 | 16:03:57 INFO - PROCESS | 22234 | ------- Summary: start ------- 16:03:57 INFO - PROCESS | 22234 | Number of tests: 6 16:03:57 INFO - PROCESS | 22234 | 16:03:57 INFO - PROCESS | 22234 | [#0] dojo.html Cycles:165 Average:4528.34 Median:4654.65 stddev:466.93 (10.0%) stddev-sans-first:441.94 16:03:57 INFO - PROCESS | 22234 | Values: 2554.3 2616.1 2629.2 2638.5 2651.6 4412.0 4505.8 4520.0 4545.1 4549.6 4487.8 4531.1 4536.7 4581.1 4611.7 4147.1 4151.9 4166.8 4197.3 4277.9 4226.2 4240.9 4256.9 4283.6 4299.7 4172.9 4175.0 4192.0 4267.3 4268.4 4198.5 4201.2 4211.2 4233.3 4239.7 4153.5 4182.5 4196.7 4229.3 4241.6 4422.3 4494.3 4524.4 4531.3 4546.5 4817.2 4826.2 4835.2 4840.4 4848.8 4861.0 4862.8 4864.3 4865.6 4866.2 4554.7 4602.1 4603.8 4645.1 4653.9 5024.2 5053.8 5055.5 5057.5 5106.4 4658.4 4790.8 4792.8 4829.9 4851.6 4908.6 4911.2 4926.0 4933.3 4988.2 4825.8 4898.6 4905.9 4910.5 4946.4 4744.2 4760.6 4791.6 4888.3 4916.5 4098.1 4099.9 4105.4 4129.7 4144.8 3593.4 3604.5 3605.9 3631.7 3645.4 4173.7 4246.4 4256.3 4298.9 4327.7 4910.9 4955.9 4957.9 4966.3 4978.9 4232.6 4265.3 4267.6 4295.5 4314.7 4324.3 4384.5 4403.3 4453.5 4465.5 4632.7 4648.8 4652.3 4654.7 4679.2 4854.9 4875.0 4899.2 4906.2 4906.8 4608.0 4636.8 4649.0 4659.6 4687.7 4830.7 4841.1 4857.2 4864.6 4903.0 4806.4 4919.5 4921.2 4926.5 4969.6 4750.0 4796.6 4797.2 4814.4 4843.2 4756.6 4782.7 4788.4 4798.4 4842.8 4637.5 4686.0 4723.6 4738.2 4783.8 4735.3 4760.2 4797.2 4806.3 4820.5 4679.5 4681.7 4682.5 4686.1 4733.4 16:03:57 INFO - PROCESS | 22234 | 16:03:57 INFO - PROCESS | 22234 | [#1] ext.html Cycles:180 Average:42790.13 Median:33259.92 stddev:69489.13 (208.9%) stddev-sans-first:69611.47 16:03:57 INFO - PROCESS | 22234 | Values: 486.6 528.2 528.8 532.8 547.2 27071.5 35135.8 35526.8 35616.3 35721.8 37990.2 38555.2 38556.6 38557.8 38651.6 7148.4 7316.3 7685.8 7869.2 7873.8 9981.4 10249.1 10254.5 10256.2 10258.7 9948.0 10054.7 10055.4 10057.7 10074.0 9817.8 9897.5 9898.1 9911.8 9916.1 9717.2 9830.3 9846.8 9858.5 9860.6 39415.8 40110.8 40269.2 40331.8 40442.6 3223.8 3233.7 3578.2 3829.6 3879.9 27665.4 27942.6 28232.7 29281.4 29309.7 3479.3 3504.3 3584.0 3589.7 3610.7 256078.0 258558.0 258629.0 259463.0 260106.0 45421.3 63691.7 64382.4 64418.0 64483.7 46020.0 46097.8 46514.8 46540.3 46617.0 13843.2 14222.1 14256.0 14264.9 14269.3 11180.9 11260.5 11263.2 11362.4 11381.3 15539.2 15640.8 15724.4 15753.7 15781.9 6268.0 6294.5 6322.5 6326.8 6488.0 910.4 943.7 970.7 1019.3 1032.7 28266.6 28346.8 28429.3 28668.7 28980.6 1037.9 1039.5 1078.8 1092.4 1157.6 14282.1 14825.0 14869.7 14973.6 15080.5 299999.0 301846.0 303436.0 304354.0 304933.0 49754.8 50268.0 50313.0 50388.0 50442.7 1214.0 1254.8 1254.8 1256.1 1265.8 26564.9 27877.2 27948.7 28298.7 28382.1 44542.3 44585.1 44776.0 44962.3 45005.8 232262.0 232530.0 233203.0 233484.0 234205.0 27204.7 27776.4 32736.2 33239.3 33642.7 37559.6 37624.6 37873.6 37894.4 45214.0 32176.7 32917.0 33289.5 33569.8 34029.3 32899.0 33202.0 33280.5 33444.3 33592.3 28498.7 31681.5 32830.5 35752.0 35991.6 27735.6 30709.5 33817.3 35614.6 35691.0 23541.8 23563.8 23645.5 23795.3 23950.3 16:03:57 INFO - PROCESS | 22234 | 16:03:57 INFO - PROCESS | 22234 | [#2] jquery.html Cycles:180 Average:22751.19 Median:363.84 stddev:59865.50 (16453.6%) stddev-sans-first:60009.80 16:03:57 INFO - PROCESS | 22234 | Values: 343.7 348.6 361.2 366.5 368.8 12092.1 16285.8 16797.9 16869.6 17296.6 16606.9 16683.7 17038.1 17098.9 17263.0 4917.1 5071.4 5116.8 5129.1 5150.8 5048.8 5124.1 5142.6 5143.5 5170.2 5124.4 5136.8 5137.0 5138.0 5139.8 4879.7 5035.8 5040.2 5052.5 5120.8 4480.9 4510.8 4516.3 4518.3 4518.8 19136.9 20080.7 20107.0 20214.9 20258.5 2049.3 2072.9 2082.5 2084.8 2559.4 11286.6 13011.5 13019.5 13436.4 13466.7 1813.6 1840.2 1870.6 1933.8 1955.9 55945.0 58163.7 58620.0 58931.7 59763.7 9074.5 9791.2 9956.3 10238.6 10398.5 12303.1 12825.6 12830.5 12839.1 12849.7 7004.8 7160.5 7307.8 7430.0 7464.4 7132.1 7212.5 7276.4 7328.2 7332.4 6160.4 6297.7 6303.6 6310.7 6335.1 1654.9 1716.3 1776.6 1828.1 1850.5 852.9 898.8 926.4 995.3 1017.1 17307.1 17423.8 17535.2 18007.3 18073.4 868.6 902.3 917.4 920.4 936.6 7255.7 10052.0 10259.7 10356.5 10500.2 241348.0 244234.0 421734.0 423654.0 427069.0 74772.6 75191.6 75621.0 75804.6 77841.0 987.1 998.8 1009.3 1017.5 1021.2 15007.4 15209.5 15216.8 15395.4 15692.6 31971.0 33795.3 34101.7 34234.5 34444.8 43672.6 47025.5 47108.3 47119.5 47607.0 7212.8 7396.7 7475.3 7557.5 7706.4 9452.9 10862.9 11214.9 11515.9 11549.3 9730.0 9874.0 10083.9 10100.7 10565.5 10135.8 10196.4 10258.3 10290.0 10317.7 10201.9 10649.8 10848.6 10969.1 11023.7 7455.4 7473.4 7508.8 7638.5 7798.8 9666.4 10497.4 10607.7 10755.0 10827.4 16:03:57 INFO - PROCESS | 22234 | 16:03:57 INFO - PROCESS | 22234 | [#3] mootools.html Cycles:180 Average:5276.13 Median:6214.30 stddev:2768.33 (44.5%) stddev-sans-first:2759.64 16:03:57 INFO - PROCESS | 22234 | Values: 1260.5 1452.5 1465.1 1622.1 1770.4 7255.3 7462.1 7483.7 7491.3 7495.0 7081.4 7225.5 7225.8 7248.5 7276.0 1951.4 2177.7 2220.9 2225.5 2247.5 2191.9 2202.8 2202.8 2203.2 2203.7 2117.1 2261.9 2265.2 2266.6 2267.1 2245.4 2271.3 2276.3 2297.7 2297.8 2213.4 2228.4 2244.9 2248.3 2294.8 7614.3 7660.3 7662.3 7674.0 7694.5 4553.6 4680.6 4706.5 4713.0 4722.3 2983.4 3102.1 3115.8 3144.7 3160.7 931.8 935.2 941.3 996.2 999.8 10093.9 10165.5 10171.6 10193.5 10216.2 4018.4 4186.7 4219.8 4325.8 4327.1 8271.8 8314.8 8317.6 8356.3 8382.5 4133.1 4631.9 4639.0 4641.0 4679.0 4123.7 4210.4 4212.2 4219.2 4252.0 3247.4 3334.6 3356.4 3387.2 3396.9 1026.1 1031.3 1031.5 1032.6 1089.0 1169.6 1196.6 1201.4 1210.6 1239.9 7192.2 7299.9 7328.6 7353.8 7357.7 452.9 464.2 466.0 468.7 469.0 5597.6 5647.9 5656.2 5659.9 5691.6 9169.5 9312.3 9343.8 9397.2 9549.4 9261.5 9304.4 9304.9 9357.9 9395.8 7117.6 7221.2 7337.7 7347.9 7356.4 6915.8 6942.8 6962.5 6983.8 7009.4 8177.6 8373.2 8493.9 8563.7 8576.8 8628.3 8788.5 8834.8 8846.7 8864.6 5917.8 6298.6 6425.4 6447.4 6616.6 7150.6 7164.5 7197.4 7220.0 7225.3 6350.7 6401.1 6434.5 6452.9 6453.9 6378.9 6422.3 6459.5 6525.0 6529.9 6729.5 6760.4 6777.2 6840.7 6852.2 5977.1 6010.6 6041.4 6123.5 6130.0 6342.8 6348.0 6370.5 6393.7 6402.2 16:03:57 INFO - PROCESS | 22234 | 16:03:57 INFO - PROCESS | 22234 | [#4] prototype.html Cycles:180 Average:4619.16 Median:5316.11 stddev:1358.03 (25.5%) stddev-sans-first:1322.92 16:03:57 INFO - PROCESS | 22234 | Values: 318.8 320.6 323.6 325.7 329.0 5267.2 5271.5 5277.9 5282.9 5397.4 5288.1 5313.6 5318.7 5322.1 5323.8 3931.2 4019.7 4082.6 4121.2 4139.4 4059.2 4089.3 4089.9 4096.4 4131.9 4086.5 4090.8 4092.2 4102.9 4118.3 3926.3 4027.8 4109.4 4113.8 4115.5 3620.2 3630.0 3636.1 3643.6 3646.2 5048.5 5056.1 5068.0 5071.1 5079.2 4751.1 4753.6 4754.0 4758.4 4763.1 5573.3 5577.8 5581.1 5581.4 5585.7 4004.8 4007.1 4008.8 4011.9 4015.6 5618.8 5802.5 5808.1 5846.6 5916.4 3897.7 3922.6 3924.7 3929.4 3934.4 3971.9 3981.1 3982.9 3985.1 3986.5 4609.3 4610.8 4614.5 4615.9 4616.3 5606.8 5615.9 5619.6 5620.9 5624.8 1407.3 1423.2 1424.6 1424.8 1426.8 903.3 932.4 941.2 946.2 966.1 4840.6 4843.7 4848.4 4863.4 4867.7 5715.5 5719.8 5754.1 5781.6 5787.6 4847.2 4848.2 4855.6 4857.9 4873.5 3061.3 3090.7 3097.2 3098.1 3098.2 5395.7 5422.4 5423.1 5438.9 5444.2 5722.9 5865.9 5884.3 5892.5 5899.4 5399.4 5414.5 5423.2 5432.1 5434.9 5735.7 5736.8 5739.3 5748.6 5750.0 5619.6 5623.0 5626.7 5631.5 5632.3 5417.3 5427.2 5427.5 5429.8 5431.9 3857.5 3987.1 4008.4 4020.2 4037.1 5778.8 5792.6 5798.7 5800.9 5807.3 5586.8 5595.8 5601.2 5602.5 5602.7 5580.2 5586.6 5587.9 5595.7 5597.3 5486.1 5500.6 5506.2 5509.6 5510.1 5465.8 5686.5 5696.3 5696.8 5697.7 5521.1 5538.8 5555.3 5560.2 5561.4 16:03:57 INFO - PROCESS | 22234 | 16:03:57 INFO - PROCESS | 22234 | [#5] yui.html Cycles:180 Average:12403.00 Median:50538.37 stddev:14076.27 (27.9%) stddev-sans-first:14088.18 16:03:57 INFO - PROCESS | 22234 | Values: 668.4 702.9 711.9 726.7 742.7 12476.6 12485.3 12555.0 12663.3 12687.7 12212.6 12268.0 12273.8 12283.1 12285.0 691.3 702.4 704.1 705.1 706.1 654.4 794.9 805.4 813.2 816.5 847.3 849.1 849.8 850.9 850.9 844.6 846.9 847.9 847.9 848.2 500.1 613.4 619.6 623.0 623.9 11876.2 11916.7 11933.3 11949.4 11950.9 12053.8 12356.8 12559.1 12686.2 12722.4 9916.3 9926.1 10007.0 10017.5 10121.0 3297.3 3306.3 3345.4 3430.5 3438.3 40216.6 40566.0 40681.0 40744.4 40812.2 8810.8 8958.9 8963.1 9037.9 9064.1 17614.7 17720.1 17835.2 17879.1 17913.2 6724.1 6837.2 6839.5 6882.5 6927.8 3759.0 3791.0 3819.4 3863.1 3887.1 2942.8 2961.9 2963.9 2964.8 2965.2 495.8 496.3 502.6 517.3 517.8 552.8 584.3 625.7 637.9 639.2 7953.1 8143.3 8156.6 8328.5 8358.9 621.4 625.6 628.6 629.2 632.0 3705.5 3747.8 3823.5 3832.5 3878.3 48638.5 50379.0 50697.7 51196.0 51231.0 44349.0 44383.8 45281.0 45341.8 46406.3 41191.6 41637.0 42145.6 42613.1 42901.4 7519.1 7706.7 7806.0 7870.0 7891.0 32296.4 32297.4 32568.7 32893.3 33104.2 37846.4 37888.6 38567.2 42221.6 42391.2 9610.4 9646.7 9651.6 9811.0 9914.7 10434.8 10482.9 10494.6 10560.5 10721.0 9761.0 9762.5 9828.7 10207.4 10330.5 9873.4 9980.6 10121.8 10349.3 10396.5 9485.4 9881.4 9914.6 10217.7 10244.8 7940.8 7972.8 8049.6 8095.8 8316.8 8117.7 8252.4 8471.8 8676.9 8709.7 16:03:57 INFO - PROCESS | 22234 | -------- Summary: end -------- 16:03:57 INFO - PROCESS | 22234 | 16:03:58 INFO - TEST-INFO | 22234: exit 0 16:03:58 INFO - TEST-OK | dromaeo_css | took 1115514ms 16:03:58 INFO - TEST-START | kraken 16:03:58 INFO - operating with platform_type : linux_ 16:03:58 INFO - Initialising browser for kraken test... 16:03:58 INFO - TEST-INFO | started process 22413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkA_6gu/profile http://localhost:50976/getInfo.html) 16:04:02 INFO - PROCESS | 22413 | __metrics Screen width/height:1600/1200 16:04:02 INFO - PROCESS | 22413 | colorDepth:24 16:04:02 INFO - PROCESS | 22413 | Browser inner width/height: 1024/697 16:04:02 INFO - PROCESS | 22413 | __metrics 16:04:03 ERROR - PROCESS | 22413 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:04:04 INFO - TEST-INFO | 22413: exit 0 16:04:04 INFO - Browser initialized. 16:04:04 INFO - Running cycle 1/1 for kraken test... 16:04:04 INFO - TEST-INFO | started process 22498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkA_6gu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:16 INFO - PROCESS | 22498 | RSS: Main: 158007296 16:04:16 INFO - PROCESS | 22498 | 16:04:18 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50976/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:19 INFO - PROCESS | 22498 | RSS: Main: 199008256 16:04:19 INFO - PROCESS | 22498 | 16:04:22 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50976/tests/kraken/driver.html?testName=audio-dft) 16:04:22 INFO - PROCESS | 22498 | RSS: Main: 189022208 16:04:22 INFO - PROCESS | 22498 | 16:04:25 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50976/tests/kraken/driver.html?testName=audio-fft) 16:04:26 INFO - PROCESS | 22498 | RSS: Main: 174514176 16:04:26 INFO - PROCESS | 22498 | 16:04:28 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50976/tests/kraken/driver.html?testName=audio-oscillator) 16:04:29 INFO - PROCESS | 22498 | RSS: Main: 174342144 16:04:29 INFO - PROCESS | 22498 | 16:04:31 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:04:31 INFO - PROCESS | 22498 | RSS: Main: 177823744 16:04:31 INFO - PROCESS | 22498 | 16:04:34 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50976/tests/kraken/driver.html?testName=imaging-darkroom) 16:04:35 INFO - PROCESS | 22498 | RSS: Main: 178671616 16:04:35 INFO - PROCESS | 22498 | 16:04:38 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50976/tests/kraken/driver.html?testName=imaging-desaturate) 16:04:39 INFO - PROCESS | 22498 | RSS: Main: 178216960 16:04:39 INFO - PROCESS | 22498 | 16:04:42 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50976/tests/kraken/driver.html?testName=json-parse-financial) 16:04:42 INFO - PROCESS | 22498 | RSS: Main: 177381376 16:04:42 INFO - PROCESS | 22498 | 16:04:44 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:04:45 INFO - PROCESS | 22498 | RSS: Main: 191922176 16:04:45 INFO - PROCESS | 22498 | 16:04:47 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50976/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:04:47 INFO - PROCESS | 22498 | RSS: Main: 189825024 16:04:47 INFO - PROCESS | 22498 | 16:04:49 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:04:50 INFO - PROCESS | 22498 | RSS: Main: 198365184 16:04:50 INFO - PROCESS | 22498 | 16:04:52 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:04:53 INFO - PROCESS | 22498 | RSS: Main: 205451264 16:04:53 INFO - PROCESS | 22498 | 16:04:55 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:04:56 INFO - PROCESS | 22498 | RSS: Main: 204619776 16:04:56 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:50976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50976/tests/kraken/driver.html?testName=ai-astar) 16:04:58 INFO - PROCESS | 22498 | RSS: Main: 264904704 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | __start_tp_report 16:04:58 INFO - PROCESS | 22498 | _x_x_mozilla_page_load 16:04:58 INFO - PROCESS | 22498 | _x_x_mozilla_page_load_details 16:04:58 INFO - PROCESS | 22498 | |i|pagename|runs| 16:04:58 INFO - PROCESS | 22498 | |0;ai-astar;110;112;106;112;112;112;101;112;111;113 16:04:58 INFO - PROCESS | 22498 | |1;audio-beat-detection;154;129;152;185;133;154;151;130;172;132 16:04:58 INFO - PROCESS | 22498 | |2;audio-dft;162;161;160;162;159;162;162;161;162;162 16:04:58 INFO - PROCESS | 22498 | |3;audio-fft;74;74;112;96;73;73;73;109;93;73 16:04:58 INFO - PROCESS | 22498 | |4;audio-oscillator;93;94;134;92;93;93;149;94;100;139 16:04:58 INFO - PROCESS | 22498 | |5;imaging-gaussian-blur;117;117;116;117;118;116;117;117;117;117 16:04:58 INFO - PROCESS | 22498 | |6;imaging-darkroom;147;146;147;146;147;146;146;146;146;146 16:04:58 INFO - PROCESS | 22498 | |7;imaging-desaturate;96;96;95;96;95;96;95;96;96;95 16:04:58 INFO - PROCESS | 22498 | |8;json-parse-financial;65;64;65;65;65;65;66;74;63;64 16:04:58 INFO - PROCESS | 22498 | |9;json-stringify-tinderbox;63;64;64;65;64;64;65;64;64;65 16:04:58 INFO - PROCESS | 22498 | |10;stanford-crypto-aes;82;82;83;83;83;81;83;83;85;89 16:04:58 INFO - PROCESS | 22498 | |11;stanford-crypto-ccm;129;122;113;132;116;121;121;114;116;114 16:04:58 INFO - PROCESS | 22498 | |12;stanford-crypto-pbkdf2;140;130;139;141;140;129;142;140;143;139 16:04:58 INFO - PROCESS | 22498 | |13;stanford-crypto-sha256-iterative;72;67;66;66;65;66;72;64;67;65 16:04:58 INFO - PROCESS | 22498 | __end_tp_report 16:04:58 INFO - PROCESS | 22498 | __start_cc_report 16:04:58 INFO - PROCESS | 22498 | _x_x_mozilla_cycle_collect,1138 16:04:58 INFO - PROCESS | 22498 | __end_cc_report 16:04:58 INFO - PROCESS | 22498 | __startTimestamp1458774298593__endTimestamp 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | ------- Summary: start ------- 16:04:58 INFO - PROCESS | 22498 | Number of tests: 14 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:3.75 (3.4%) stddev-sans-first:3.98 16:04:58 INFO - PROCESS | 22498 | Values: 110.0 112.0 106.0 112.0 112.0 112.0 101.0 112.0 111.0 113.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:153.00 stddev:18.84 (12.3%) stddev-sans-first:19.90 16:04:58 INFO - PROCESS | 22498 | Values: 154.0 129.0 152.0 185.0 133.0 154.0 151.0 130.0 172.0 132.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 16:04:58 INFO - PROCESS | 22498 | Values: 162.0 161.0 160.0 162.0 159.0 162.0 162.0 161.0 162.0 162.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#3] audio-fft Cycles:10 Average:85.00 Median:73.50 stddev:16.01 (21.8%) stddev-sans-first:16.48 16:04:58 INFO - PROCESS | 22498 | Values: 74.0 74.0 112.0 96.0 73.0 73.0 73.0 109.0 93.0 73.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:93.00 stddev:22.86 (24.6%) stddev-sans-first:23.59 16:04:58 INFO - PROCESS | 22498 | Values: 93.0 94.0 134.0 92.0 93.0 93.0 149.0 94.0 100.0 139.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:04:58 INFO - PROCESS | 22498 | Values: 117.0 117.0 116.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 16:04:58 INFO - PROCESS | 22498 | Values: 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:04:58 INFO - PROCESS | 22498 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:3.06 (4.7%) stddev-sans-first:3.24 16:04:58 INFO - PROCESS | 22498 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 66.0 74.0 63.0 64.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 16:04:58 INFO - PROCESS | 22498 | Values: 63.0 64.0 64.0 65.0 64.0 64.0 65.0 64.0 64.0 65.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.22 (2.7%) stddev-sans-first:2.30 16:04:58 INFO - PROCESS | 22498 | Values: 82.0 82.0 83.0 83.0 83.0 81.0 83.0 83.0 85.0 89.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:121.00 stddev:6.53 (5.4%) stddev-sans-first:6.02 16:04:58 INFO - PROCESS | 22498 | Values: 129.0 122.0 113.0 132.0 116.0 121.0 121.0 114.0 116.0 114.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.30 Median:140.00 stddev:4.81 (3.4%) stddev-sans-first:5.06 16:04:58 INFO - PROCESS | 22498 | Values: 140.0 130.0 139.0 141.0 140.0 129.0 142.0 140.0 143.0 139.0 16:04:58 INFO - PROCESS | 22498 | 16:04:58 INFO - PROCESS | 22498 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.50 stddev:2.79 (4.2%) stddev-sans-first:2.30 16:04:58 INFO - PROCESS | 22498 | Values: 72.0 67.0 66.0 66.0 65.0 66.0 72.0 64.0 67.0 65.0 16:04:58 INFO - PROCESS | 22498 | -------- Summary: end -------- 16:04:58 INFO - PROCESS | 22498 | 16:04:59 INFO - TEST-INFO | 22498: exit 0 16:04:59 INFO - TEST-OK | kraken | took 61174ms 16:04:59 INFO - SUITE-END | took 1176s 16:04:59 INFO - Completed test suite (00:19:36) 16:04:59 INFO - javascript benchmark 16:04:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2554.3486410965206, 2616.123598594471, 2629.1586692258484, 2638.4591158812445, 2651.642028326176, 4411.977940110303, 4505.819767209307, 4520.028193938307, 4545.136424079426, 4549.613282870956, 4487.775611219442, 4531.071130418264, 4536.7051141675765, 4581.083783243348, 4611.677182597219, 4147.129102888382, 4151.8962025949295, 4166.7708276044805, 4197.349410841324, 4277.935830962538, 4226.218149642326, 4240.893977650552, 4256.936145957813, 4283.593058659422, 4299.677524185683, 4172.91654166918, 4174.979125104355, 4192.035831758697, 4267.338562522814, 4268.423762792015, 4198.538160802309, 4201.2017716634045, 4211.241976444238, 4233.343831706091, 4239.682023848193, 4153.501579810412, 4182.498100227962, 4196.685248606367, 4229.344451610005, 4241.59704828044, 4422.29243321067, 4494.258447356182, 4524.411826462571, 4531.252343363374, 4546.499885012646, 4817.181079216542, 4826.155422800995, 4835.202191638376, 4840.394950631171, 4848.830290939835, 4861.0, 4862.78117484714, 4864.318995340655, 4865.610751139936, 4866.172750632401, 4554.681172317939, 4602.125596136723, 4603.815847366068, 4645.094206629708, 4653.860384188446, 5024.171011783015, 5053.772580233898, 5055.545000949932, 5057.494250574987, 5106.361704786902, 4658.394408726844, 4790.8323208687525, 4792.784324705397, 4829.9034019319415, 4851.56335929768, 4908.558229759267, 4911.214205727067, 4925.950740492621, 4933.28467372229, 4988.226824842155, 4825.8121123895635, 4898.559129678346, 4905.901881962341, 4910.48439913811, 4946.431160416598, 4744.217204161275, 4760.64295177863, 4791.592714619227, 4888.26675998596, 4916.532929371704, 4098.118904435561, 4099.938500922489, 4105.4252404663375, 4129.669626429938, 4144.772037537964, 3593.4250519916686, 3604.4953706481115, 3605.9278814423565, 3631.7276204284785, 3645.434957581579, 4173.728707633994, 4246.44796176495, 4256.2764330063965, 4298.871033868989, 4327.6970612057485, 4910.90178196434, 4955.876103097379, 4957.925631115536, 4966.304717339575, 4978.925316120261, 4232.640225580799, 4265.296226122717, 4267.615914567704, 4295.5060168080445, 4314.71954322968, 4324.2648749712625, 4384.473863136444, 4403.251447253974, 4453.532379100147, 4465.486469056035, 4632.698874573142, 4648.814047438133, 4652.255639097728, 4654.650901182493, 4679.181143299909, 4854.902901942012, 4874.975625121993, 4899.191633380452, 4906.215005599087, 4906.754662266943, 4607.976960115178, 4636.83771068011, 4649.0, 4659.5573420525, 4687.695299805502, 4830.734309613005, 4841.080194762983, 4857.174280372275, 4864.586510146677, 4903.04390643821, 4806.399200099988, 4919.508049195052, 4921.212605983025, 4926.5073492650445, 4969.552740253394, 4749.976250118727, 4796.616270698406, 4797.208460603962, 4814.374131362901, 4843.24929635907, 4756.643251756063, 4782.665213435026, 4788.353572267839, 4798.424189097331, 4842.757862106951, 4637.536246375335, 4686.0, 4723.574878260973, 4738.241881298975, 4783.808647654194, 4735.313379560013, 4760.190767569591, 4797.232442809134, 4806.279058141306, 4820.517948205292, 4679.532046795293, 4681.742504162304, 4682.484926657997, 4686.086213188396, 4733.36099626546], "unit": "score", "name": "dojo.html", "value": 4499.302601246184}, {"lowerIsBetter": false, "replicates": [486.57667828988787, 528.2182370092263, 528.7541293298615, 532.8348212054264, 547.2420697334192, 27071.45857082857, 35135.82432087839, 35526.82236588813, 35616.28767424657, 35721.82139089308, 37990.24019519608, 38555.228895422144, 38556.614433855655, 38557.8072109639, 38651.613483865156, 7148.392386647141, 7316.341529262365, 7685.807854803633, 7869.173736757644, 7873.842523149562, 9981.351212171221, 10249.128824049927, 10254.487275636226, 10256.179505639531, 10258.743531411737, 9947.950260248688, 10054.748631284203, 10055.396676199414, 10057.748556286115, 10074.0, 9817.754556136118, 9897.505124743733, 9898.059684329977, 9911.801763964717, 9916.057974492413, 9717.174040206592, 9830.262730295257, 9846.753831154207, 9858.457784821832, 9860.60557577696, 39415.80292098521, 40110.79944600288, 40269.19461610781, 40331.7983410084, 40442.59557404418, 3223.8065716056876, 3233.7413006959387, 3578.2127931854952, 3829.5596006459336, 3879.903002424962, 27665.446691066267, 27942.580861287097, 28232.717672823215, 29281.414371712446, 29309.70690293091, 3479.3389256041273, 3504.2991401719505, 3584.032311275967, 3589.730770192246, 3610.7291953103622, 256078.0, 258558.0, 258629.0, 259462.9999999981, 260106.0, 45421.318680219825, 63691.68154159292, 64382.356176438574, 64418.0, 64483.677581611795, 46020.0, 46097.7695111529, 46514.76742616265, 46540.301895471595, 46617.0, 13843.238621875693, 14222.146671199554, 14256.0, 14264.928675356765, 14269.286535673382, 11180.888191118147, 11260.493277802518, 11263.211575189658, 11362.375069371265, 11381.260218085798, 15539.21299050601, 15640.765388519181, 15724.371025159095, 15753.739700823906, 15781.921090394475, 6267.96866015667, 6294.464970477561, 6322.462590679844, 6326.810195694136, 6488.0, 910.4355299714219, 943.698016634684, 970.6748239339901, 1019.3293570844435, 1032.667858462575, 28266.576001359997, 28346.77157324869, 28429.289267768057, 28668.71331286702, 28980.565291520645, 1037.911777498921, 1039.5477967084344, 1078.8344610550585, 1092.4046394714899, 1157.6353448663813, 14282.143071415749, 14825.0, 14869.702605947821, 14973.550793476214, 15080.472183473526, 299999.0, 301846.0, 303436.0, 304354.0, 304933.0, 49754.751226243636, 50268.0, 50313.0, 50388.0, 50442.747786260836, 1213.969650758738, 1254.7553227120625, 1254.8494180698374, 1256.0956111599633, 1265.7848165811833, 26564.867175664, 27877.16368508948, 27948.72051279461, 28298.71701282961, 28382.148535543965, 44542.3318650227, 44585.10829783451, 44776.0, 44962.3255651159, 45005.774971124934, 232262.0, 232530.0, 233203.0, 233484.0, 234205.0, 27204.72795272022, 27776.44447111087, 32736.181595460304, 33239.33521329608, 33642.66357336493, 37559.62440375561, 37624.62375376211, 37873.62126378701, 37894.431583525715, 45214.0, 32176.678233217368, 32917.0, 33289.500657490644, 33569.83215083909, 34029.31941361209, 32899.0, 33202.0, 33280.50079248765, 33444.33111337711, 33592.32815343728, 28498.715012850436, 31681.5247771279, 32830.507542386404, 35752.0, 35991.64008359883, 27735.63597477498, 30709.539356909216, 33817.32365352728, 35614.64385356217, 35691.0, 23541.764582353957, 23563.764362356844, 23645.527089458457, 23795.286141415785, 23950.281491554586], "unit": "score", "name": "ext.html", "value": 17623.55529898033}, {"lowerIsBetter": false, "replicates": [343.6958291911657, 348.59388812033967, 361.199942128186, 366.4887481962662, 368.83402468889005, 12092.093093018015, 16285.83714162858, 16797.91601041993, 16869.578260543494, 17296.56758581036, 16606.916965415156, 16683.666326673458, 17038.148092595384, 17098.914505427485, 17263.0, 4917.09033828741, 5071.391433028042, 5116.846494605168, 5129.102407078765, 5150.819721309755, 5048.823291184809, 5124.128898087334, 5142.588592912558, 5143.4599367066485, 5170.172772356424, 5124.436312005676, 5136.820211292606, 5137.049645815518, 5138.049460849736, 5139.845804625848, 4879.6828206166665, 5035.77339019745, 5040.16837221858, 5052.469490703478, 5120.820771273006, 4480.8879778005485, 4510.774461276923, 4516.345129956171, 4518.299663552155, 4518.841840535565, 19136.904315478474, 20080.69878951817, 20107.0, 20214.898925505426, 20258.49353766153, 2049.252023011605, 2072.89635518225, 2082.4506925718683, 2084.833213342929, 2559.436923876744, 11286.604968826052, 13011.544595939096, 13019.479220831156, 13436.395362208725, 13466.663333416744, 1813.6372725454962, 1840.1719226348198, 1870.560418301698, 1933.825955663997, 1955.8533110016806, 55945.0, 58163.70918145382, 58620.0, 58931.70534147345, 59763.701181493816, 9074.500902450429, 9791.216702663769, 9956.303058785816, 10238.641647542448, 10398.480075996169, 12303.138780285473, 12825.551105711254, 12830.486780528861, 12839.101262911694, 12849.678758030937, 7004.789856304319, 7160.534565253346, 7307.7807665770115, 7430.034095567649, 7464.440166987498, 7132.1441427029085, 7212.472727091975, 7276.417886569062, 7328.193898671142, 7332.41340692754, 6160.44555989963, 6297.748090076346, 6303.621782693053, 6310.684465776692, 6335.11308416822, 1654.8924319919167, 1716.262007336857, 1776.6091459878805, 1828.1225011994318, 1850.4911149433744, 852.9189726975927, 898.820235952812, 926.4487629860222, 995.2635050063046, 1017.0947856407803, 17307.134643267786, 17423.825761742475, 17535.210915508833, 18007.279708811762, 18073.36743213981, 868.6438560190292, 902.3412908576645, 917.3532659475054, 920.3787443475761, 936.5972631768406, 7255.709771609077, 10052.0, 10259.692209233735, 10356.533955972, 10500.212484063573, 241348.0, 244234.0, 421734.0, 423654.0, 427069.0, 74772.62613686897, 75191.62404188054, 75621.0, 75804.62097689476, 77841.0, 987.0672214757129, 998.8202123617818, 1009.3136667066318, 1017.4912543728136, 1021.2340744441668, 15007.399704012154, 15209.543713688607, 15216.771748424004, 15395.384184632938, 15692.607684807972, 31971.0, 33795.32409351848, 34101.65898340985, 34234.48648270228, 34444.82777586096, 43672.56327436685, 47025.529744702115, 47108.29337560008, 47119.52880471152, 47607.0, 7212.783616491513, 7396.741114060982, 7475.289847464483, 7557.5465472071855, 7706.383489320953, 9452.858207127036, 10862.945685271523, 11214.887851121384, 11515.884841151481, 11549.307041577533, 9730.0, 9873.95063024709, 10083.949580252345, 10100.747481313027, 10565.471726413802, 10135.847962280719, 10196.388216706724, 10258.333208341433, 10290.0, 10317.690469285933, 10201.948990255001, 10649.787004260026, 10848.566057357617, 10969.122470202205, 11023.669289921316, 7455.366293865082, 7473.40212782987, 7508.774736757906, 7638.50349727266, 7798.805029874072, 9666.420014799134, 10497.42264175447, 10607.734806629896, 10755.0, 10827.350358978487], "unit": "score", "name": "jquery.html", "value": 8226.758303949067}, {"lowerIsBetter": false, "replicates": [1260.4643026713645, 1452.5279284232624, 1465.0916431812275, 1622.1321592947768, 1770.442310672138, 7255.310745479178, 7462.067241594801, 7483.73806916758, 7491.288327608882, 7495.0, 7081.362677359037, 7225.530340527862, 7225.819354516139, 7248.456365772562, 7276.0, 1951.4243298226986, 2177.7277840269967, 2220.877851718159, 2225.4658881868395, 2247.4606094537276, 2191.901364438604, 2202.757696653367, 2202.7907348801837, 2203.151786562177, 2203.724534433196, 2117.089651449876, 2261.9208327708534, 2265.2184996176293, 2266.6260067088992, 2267.0818318581, 2245.36007237938, 2271.2731925783755, 2276.3057267533395, 2297.7242730872235, 2297.7587353327826, 2213.4134454369605, 2228.3649159989327, 2244.932652020442, 2248.303026061926, 2294.804941579968, 7614.276643718893, 7660.310572048486, 7662.310392064685, 7674.0, 7694.538327700356, 4553.5674110959735, 4680.602148817355, 4706.458757242926, 4712.95287047132, 4722.315264286659, 2983.4033193361197, 3102.069379186235, 3115.8442077896016, 3144.701253380925, 3160.747140228776, 931.8043210925714, 935.242453612576, 941.3410612571228, 996.1632228927735, 999.8400255959084, 10093.89906100937, 10165.491725413774, 10171.643992460302, 10193.541290641939, 10216.233782466345, 4018.3771515415156, 4186.665066794649, 4219.767912764766, 4325.76208308546, 4327.091310824699, 8271.751847444586, 8314.792130196793, 8317.584120793936, 8356.289715374262, 8382.538960357238, 4133.0700592367075, 4631.930521042187, 4639.048994956026, 4640.976795116003, 4678.976605117021, 4123.711340206157, 4210.368444733314, 4212.241796476664, 4219.177260434186, 4252.043290259729, 3247.366763481146, 3334.566506354207, 3356.3622911646708, 3387.187075102007, 3396.9490457643155, 1026.081656917055, 1031.2523420520063, 1031.510032734445, 1032.5766435761302, 1089.0144419300545, 1169.6198735411026, 1196.646989138189, 1201.4293210724836, 1210.5581462766204, 1239.863615002349, 7192.244814294424, 7299.927000730031, 7328.633568321563, 7353.779386618303, 7357.668904899292, 452.8596135198033, 464.2409660205521, 466.0446085524661, 468.67192964924686, 468.9624830013591, 5597.552195824324, 5647.887042259132, 5656.208130861683, 5659.886802263932, 5691.630044047124, 9169.541522923828, 9312.255019598417, 9343.813123737624, 9397.201237894855, 9549.379290346105, 9261.536923153815, 9304.395214311047, 9304.906950930404, 9357.859632105525, 9395.765105872271, 7117.6085315308155, 7221.169565499929, 7337.74317898871, 7347.88978165328, 7356.448266379936, 6915.792526224222, 6942.791716248521, 6962.512624116466, 6983.790486285419, 7009.3691567757105, 8177.550234736908, 8373.162683731578, 8493.873459637802, 8563.700270490503, 8576.785580360542, 8628.266597339296, 8788.516631585324, 8834.823303534022, 8846.690365837165, 8864.556772161237, 5917.763289468545, 6298.590591611531, 6425.421712045938, 6447.4197322241225, 6616.603003819786, 7150.64246787669, 7164.462665300019, 7197.388222001188, 7220.025296585104, 7225.349718525358, 6350.650714210578, 6401.103845461732, 6434.485241180788, 6452.903206451813, 6453.870922581616, 6378.90431643535, 6422.293547709654, 6459.483241340776, 6525.0, 6529.9020514691365, 6729.495287853332, 6760.357766012221, 6777.152855893013, 6840.692168852314, 6852.211995620568, 5977.103434484862, 6010.639361638316, 6041.395860413923, 6123.540734444845, 6130.0, 6342.809715708536, 6348.047792831112, 6370.490360771035, 6393.744250230125, 6402.199725034371], "unit": "score", "name": "mootools.html", "value": 4251.020707937284}, {"lowerIsBetter": false, "replicates": [318.78800597602594, 320.624868903383, 323.6068177164745, 325.7068638225595, 328.95723555937724, 5267.157254839227, 5271.472852714726, 5277.920831187535, 5282.89434211316, 5397.379301380342, 5288.127458969266, 5313.57491400688, 5318.654287471311, 5322.121849894773, 5323.8136665216725, 3931.174453364797, 4019.7387169834014, 4082.5509193988637, 4121.155163191554, 4139.3997870308785, 4059.2490389278078, 4089.3048181809163, 4089.8568550100754, 4096.426500289962, 4131.876043718678, 4086.5300490443533, 4090.8159132839096, 4092.1611069730634, 4102.8974275643195, 4118.341065429532, 3926.293267211915, 4027.7583344999393, 4109.4246805447265, 4113.814878330452, 4115.506139263278, 3620.2035552178477, 3630.0, 3636.1455058061333, 3643.5809881863397, 3646.2342907989355, 5048.495150484959, 5056.115179843513, 5068.037072956126, 5071.137906555894, 5079.212722028092, 4751.073540659573, 4753.572178503951, 4754.02542478791, 4758.405199350082, 4763.118823017753, 5573.27547418837, 5577.776888924438, 5581.134924086773, 5581.386047534768, 5585.664860108406, 4004.83980640774, 4007.1184339445276, 4008.819603117867, 4011.859584914514, 4015.598440155961, 5618.803341883015, 5802.477777000048, 5808.12878068289, 5846.561507886926, 5916.4379383958885, 3897.713754461021, 3922.5685174630767, 3924.6860251179837, 3929.410588411704, 3934.429507721364, 3971.860984865516, 3981.0843505993785, 3982.9203415932097, 3985.143194213258, 3986.481757371523, 4609.331646911179, 4610.76946152691, 4614.492405835355, 4615.930761038587, 4616.3306320584, 5606.831795046155, 5615.943840561624, 5619.578531610146, 5620.85947851307, 5624.803131890364, 1407.3174510362467, 1423.1745587559192, 1424.608232736006, 1424.8076509671062, 1426.8359138698975, 903.2638399704351, 932.4125800745622, 941.223490620241, 946.1910066892846, 966.087047739879, 4840.588549973291, 4843.733594652328, 4848.442429120626, 4863.392075990501, 4867.6836005660225, 5715.5427565794635, 5719.7712091516705, 5754.108113242454, 5781.624194427349, 5787.594868359174, 4847.175980083394, 4848.151573474628, 4855.562999330006, 4857.9028419432125, 4873.512648735169, 3061.3265081681993, 3090.6909309068915, 3097.241175911916, 3098.10155055036, 3098.194469437917, 5395.676259424368, 5422.3764267109, 5423.129020487925, 5438.945610543923, 5444.156155795858, 5722.856928576819, 5865.853353666107, 5884.293884733774, 5892.499137573354, 5899.380565040609, 5399.37907140676, 5414.458554144554, 5423.186522021729, 5432.13085906261, 5434.91847622286, 5735.655860648374, 5736.770529178953, 5739.253896993364, 5748.5688573358, 5750.0, 5619.550435965031, 5623.0, 5626.690532020778, 5631.493165615114, 5632.2678051853, 5417.322834645669, 5427.213054107211, 5427.511523962862, 5429.7556609953435, 5431.864203394789, 3857.517810273716, 3987.0829709167633, 4008.3586626139677, 4020.2361551306326, 4037.051292946214, 5778.768849245983, 5792.5655575832825, 5798.6810725410505, 5800.912986305125, 5807.274090738658, 5586.804461843816, 5595.832125036255, 5601.159826026129, 5602.523785478117, 5602.66384016944, 5580.190872323572, 5586.636868603528, 5587.888242235052, 5595.692236927008, 5597.328320601554, 5486.149646804752, 5500.614956953135, 5506.174073888948, 5509.614326997072, 5510.118381059011, 5465.754041068241, 5686.545076393962, 5696.259486266758, 5696.772129114789, 5697.658140511582, 5521.089020311603, 5538.750756215899, 5555.2778138841695, 5560.165975103605, 5561.360443549043], "unit": "score", "name": "prototype.html", "value": 4186.434350540913}, {"lowerIsBetter": false, "replicates": [668.4485299627805, 702.9121359830021, 711.8647456983173, 726.7492715013321, 742.7387126523407, 12476.563320283793, 12485.25088494691, 12555.0, 12663.3035183065, 12687.746245075094, 12212.572559960403, 12268.01855851532, 12273.815892761593, 12283.14018018739, 12285.0, 691.3086913086913, 702.3783951203171, 704.1303989572873, 705.0587465733227, 706.1067749297143, 654.3750718064261, 794.9085855126648, 805.4120492040814, 813.1786895235825, 816.4733746733353, 847.3348421489133, 849.0617867256685, 849.8257857139303, 850.8893843800297, 850.9489430634151, 844.5903736687701, 846.949183049019, 847.8897743293394, 847.9024912135121, 848.240824462106, 500.0598874116674, 613.4325748682451, 619.5632079384023, 623.0187454758773, 623.9376062393725, 11876.228045177037, 11916.702082447922, 11933.34366609836, 11949.402529873472, 11950.880491195063, 12053.758924821543, 12356.752864942651, 12559.120861539695, 12686.238825670489, 12722.363881805873, 9916.256280778898, 9926.106650401498, 10007.0, 10017.499125043792, 10121.0, 3297.3240485700376, 3306.2560923792194, 3345.414552453311, 3430.5025771263026, 3438.3123375325035, 40216.59783402158, 40566.0, 40680.982975425555, 40744.38883416751, 40812.183756325, 8810.823783524422, 8958.86561701575, 8963.148500892405, 9037.909620903838, 9064.138906803842, 17614.735778963324, 17720.113994300234, 17835.197416116305, 17879.10604469797, 17913.19390627425, 6724.125863637793, 6837.247902730695, 6839.521233513607, 6882.483813713891, 6927.826804329932, 3758.9629895939574, 3791.0, 3819.3698039823116, 3863.111484358557, 3887.1253967857006, 2942.838143902106, 2961.8815247390294, 2963.881444742186, 2964.777641676883, 2965.1697524693122, 495.7620342235747, 496.3473032961644, 502.5828562293288, 517.3119750731518, 517.8394697643743, 552.7678375082475, 584.2871696530226, 625.7309356976543, 637.9075034120027, 639.2424976402978, 7953.085395179628, 8143.267105960492, 8156.5513896735065, 8328.500289982621, 8358.916410835935, 621.4313902778997, 625.565232163651, 628.6416742456847, 629.2291942370559, 631.9842003949846, 3705.5368078990127, 3747.7938713371027, 3823.5411750590106, 3832.5400951885395, 3878.2825177342283, 48638.5136148634, 50379.0, 50697.74651126794, 51196.0, 51231.0, 44349.0, 44383.77808110939, 45281.0, 45341.77329113399, 46406.30390544145, 41191.588084118775, 41637.0, 42145.578544214775, 42613.14773704509, 42901.35647965283, 7519.135299440634, 7706.730264440717, 7805.960970195113, 7870.0, 7891.0, 32296.35407291888, 32297.35405291928, 32568.67431325751, 32893.34213315672, 33104.1723956903, 37846.43230351492, 37888.62111378851, 38567.228655426174, 42221.577784221765, 42391.15217695691, 9610.375325603813, 9646.728962637228, 9651.613935442503, 9810.950945245228, 9914.652987145415, 10434.791304174027, 10482.947585262025, 10494.580216791242, 10560.471976400995, 10721.0, 9760.951195243979, 9762.46306453152, 9828.655997040069, 10207.387556746618, 10330.535125919201, 9873.40759554429, 9980.600775969171, 10121.797564048826, 10349.27555071168, 10396.532156052845, 9485.430874147572, 9881.357711748713, 9914.603415863285, 10217.693469195936, 10244.846327304947, 7940.841183176189, 7972.832130693019, 8049.637766300648, 8095.757127286191, 8316.750497485085, 8117.715879944174, 8252.422330436812, 8471.830563388821, 8676.869846952175, 8709.695160669346], "unit": "score", "name": "yui.html", "value": 5777.732184570847}], "name": "dromaeo_css", "value": 6374.333283292541}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 112.0, 112.0, 112.0, 101.0, 112.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 152.0, 185.0, 133.0, 154.0, 151.0, 130.0, 172.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 162.0, 159.0, 162.0, 162.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 112.0, 96.0, 73.0, 73.0, 73.0, 109.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 134.0, 92.0, 93.0, 93.0, 149.0, 94.0, 100.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 74.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 65.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 83.0, 83.0, 81.0, 83.0, 83.0, 85.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [129.0, 122.0, 113.0, 132.0, 116.0, 121.0, 121.0, 114.0, 116.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.8}, {"lowerIsBetter": true, "replicates": [140.0, 130.0, 139.0, 141.0, 140.0, 129.0, 142.0, 140.0, 143.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.3}, {"lowerIsBetter": true, "replicates": [72.0, 67.0, 66.0, 66.0, 65.0, 66.0, 72.0, 64.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1510.8}]} 16:04:59 INFO - Return code: 0 16:04:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:04:59 ERROR - # TBPL SUCCESS # 16:04:59 INFO - Running post-action listener: _resource_record_post_action 16:04:59 INFO - Running post-run listener: _resource_record_post_run 16:05:00 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 283873280; Read time: 0; Write time: 177196 16:05:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 3981312; Read time: 0; Write time: 1016 16:05:00 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 277504000; Read time: 0; Write time: 175296 16:05:00 INFO - Running post-run listener: _upload_blobber_files 16:05:00 INFO - Blob upload gear active. 16:05:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:05:00 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 16:05:00 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'] 16:05:00 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 16:05:01 INFO - (blobuploader) - INFO - Open directory for files ... 16:05:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:05:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:05:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:03 INFO - (blobuploader) - INFO - Done attempting. 16:05:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:05:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:05:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:04 INFO - (blobuploader) - INFO - Done attempting. 16:05:04 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:04 INFO - Return code: 0 16:05:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:05:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/456293425c0fa61251b33ef8921f99c85535d16fc5194de9df572ebad4fcb83c43df97c0f2ad29e7bc80fcb4a2210ae5fc6e5e2babcd3a669d92ee31637368ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88fe3f91182669f71a0ef7bac3ed999102c64cff6032c0170d20f92ec30877381d2c9f318ac1bcf1b849eb23bc5aa7f4da2b01681eabc552c1c5e03188aa8d7b"} 16:05:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:05:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:05:04 INFO - Contents: 16:05:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/456293425c0fa61251b33ef8921f99c85535d16fc5194de9df572ebad4fcb83c43df97c0f2ad29e7bc80fcb4a2210ae5fc6e5e2babcd3a669d92ee31637368ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88fe3f91182669f71a0ef7bac3ed999102c64cff6032c0170d20f92ec30877381d2c9f318ac1bcf1b849eb23bc5aa7f4da2b01681eabc552c1c5e03188aa8d7b"} 16:05:04 INFO - Running post-run listener: copy_logs_to_upload_dir 16:05:04 INFO - Copying logs to upload dir... 16:05:04 INFO - mkdir: /builds/slave/test/build/upload/logs 16:05:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.679292 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-03-23 16:05:03.629346) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 16:05:03.633005) ========= 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=7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229 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/456293425c0fa61251b33ef8921f99c85535d16fc5194de9df572ebad4fcb83c43df97c0f2ad29e7bc80fcb4a2210ae5fc6e5e2babcd3a669d92ee31637368ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88fe3f91182669f71a0ef7bac3ed999102c64cff6032c0170d20f92ec30877381d2c9f318ac1bcf1b849eb23bc5aa7f4da2b01681eabc552c1c5e03188aa8d7b"} build_url:https://queue.taskcluster.net/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/aBmn_t1zQB-NeHaovivABg/artifacts/public/build/firefox-48.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/456293425c0fa61251b33ef8921f99c85535d16fc5194de9df572ebad4fcb83c43df97c0f2ad29e7bc80fcb4a2210ae5fc6e5e2babcd3a669d92ee31637368ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/88fe3f91182669f71a0ef7bac3ed999102c64cff6032c0170d20f92ec30877381d2c9f318ac1bcf1b849eb23bc5aa7f4da2b01681eabc552c1c5e03188aa8d7b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 16:05:03.664713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 16:05:03.665308) ========= 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=7cf709767345e0a0c5a90e72000001d4-1458772497.486425-839737229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 16:05:03.748718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 16:05:03.749105) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 16:05:03.749489) ========= ========= Total master_lag: 0.47 =========