builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1458251266.32 results: success (0) buildid: 20160317141822 builduid: b057d080de084c62aa8ebff0f4abb589 revision: 1477dcbfb8ec44166c93473932a475a3c4dec17f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.320962) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.321487) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.321892) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006398 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.349705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.350141) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.380643) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.381037) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004644 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.430966) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.431272) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.431636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.431912) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 14:47:46-- 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% 67.0M=0s 2016-03-17 14:47:46 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108155 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.835475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.835770) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017289 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:46.871756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 14:47:46.872070) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1477dcbfb8ec44166c93473932a475a3c4dec17f --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 1477dcbfb8ec44166c93473932a475a3c4dec17f --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=14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 14:47:46,935 truncating revision to first 12 chars 2016-03-17 14:47:46,935 Setting DEBUG logging. 2016-03-17 14:47:46,935 attempt 1/10 2016-03-17 14:47:46,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1477dcbfb8ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 14:47:48,398 unpacking tar archive at: fx-team-1477dcbfb8ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.734830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 14:47:48.620654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:48.620980) ========= echo 1477dcbfb8ec44166c93473932a475a3c4dec17f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1477dcbfb8ec44166c93473932a475a3c4dec17f'] 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=14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1477dcbfb8ec44166c93473932a475a3c4dec17f program finished with exit code 0 elapsedTime=0.004320 script_repo_revision: '1477dcbfb8ec44166c93473932a475a3c4dec17f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:48.670516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:48.670814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 14:47:48.680630) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-03-17 14:47:48.680908) ========= /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=14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:47:48 INFO - MultiFileLogger online at 20160317 14:47:48 in /builds/slave/test 14:47:48 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 14:47:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:47:48 INFO - {'append_to_log': False, 14:47:48 INFO - 'base_work_dir': '/builds/slave/test', 14:47:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:47:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:47:48 INFO - 'branch': 'Fx-Team-Non-PGO', 14:47:48 INFO - 'buildbot_json_path': 'buildprops.json', 14:47:48 INFO - 'config_files': ('talos/linux_config.py',), 14:47:48 INFO - 'default_actions': ('clobber', 14:47:48 INFO - 'read-buildbot-config', 14:47:48 INFO - 'download-and-extract', 14:47:48 INFO - 'populate-webroot', 14:47:48 INFO - 'create-virtualenv', 14:47:48 INFO - 'install', 14:47:48 INFO - 'run-tests'), 14:47:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:47:48 INFO - 'download_minidump_stackwalk': True, 14:47:48 INFO - 'download_symbols': 'ondemand', 14:47:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:47:48 INFO - 'tooltool.py': '/tools/tooltool.py', 14:47:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:47:48 INFO - '/tools/misc-python/virtualenv.py')}, 14:47:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:47:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:47:48 INFO - 'installer_path': 'installer.exe', 14:47:48 INFO - 'log_level': 'info', 14:47:48 INFO - 'log_name': 'talos', 14:47:48 INFO - 'log_to_console': True, 14:47:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:47:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:47:48 INFO - 'opt_config_files': (), 14:47:48 INFO - 'pip_index': False, 14:47:48 INFO - 'sps_profile': False, 14:47:48 INFO - 'sps_profile_interval': 0, 14:47:48 INFO - 'suite': 'dromaeojs', 14:47:48 INFO - 'system_bits': '32', 14:47:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:47:48 INFO - 'title': 'talos-linux64-ix-036', 14:47:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:47:48 INFO - 'use_talos_json': True, 14:47:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:47:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:47:48 INFO - 'work_dir': 'build'} 14:47:48 INFO - ##### 14:47:48 INFO - ##### Running clobber step. 14:47:48 INFO - ##### 14:47:48 INFO - Running pre-action listener: _resource_record_pre_action 14:47:48 INFO - Running main action method: clobber 14:47:48 INFO - rmtree: /builds/slave/test/build 14:47:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:47:49 INFO - Running post-action listener: _resource_record_post_action 14:47:49 INFO - ##### 14:47:49 INFO - ##### Running read-buildbot-config step. 14:47:49 INFO - ##### 14:47:49 INFO - Running pre-action listener: _resource_record_pre_action 14:47:49 INFO - Running main action method: read_buildbot_config 14:47:49 INFO - Using buildbot properties: 14:47:49 INFO - { 14:47:49 INFO - "project": "", 14:47:49 INFO - "product": "firefox", 14:47:49 INFO - "script_repo_revision": "production", 14:47:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:47:49 INFO - "repository": "", 14:47:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:47:49 INFO - "buildid": "20160317141822", 14:47:49 INFO - "pgo_build": "False", 14:47:49 INFO - "basedir": "/builds/slave/test", 14:47:49 INFO - "buildnumber": 1466, 14:47:49 INFO - "slavename": "talos-linux64-ix-036", 14:47:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:47:49 INFO - "platform": "ubuntu64_hw", 14:47:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:47:49 INFO - "branch": "fx-team", 14:47:49 INFO - "repo_path": "integration/fx-team", 14:47:49 INFO - "revision": "1477dcbfb8ec44166c93473932a475a3c4dec17f", 14:47:49 INFO - "stage_platform": "linux64", 14:47:49 INFO - "builduid": "b057d080de084c62aa8ebff0f4abb589", 14:47:49 INFO - "slavebuilddir": "test" 14:47:49 INFO - } 14:47:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:47:49 INFO - Running post-action listener: _resource_record_post_action 14:47:49 INFO - ##### 14:47:49 INFO - ##### Running download-and-extract step. 14:47:49 INFO - ##### 14:47:49 INFO - Running pre-action listener: _resource_record_pre_action 14:47:49 INFO - Running main action method: download_and_extract 14:47:49 INFO - mkdir: /builds/slave/test/build/tests 14:47:49 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')]} 14:47:49 INFO - https://queue.taskcluster.net/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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 14:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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 14:47:51 INFO - Downloaded 1361 bytes. 14:47:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:47:51 INFO - Using the following test package requirements: 14:47:51 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:47:51 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:47:51 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:47:51 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:51 INFO - u'jsshell-linux-x86_64.zip'], 14:47:51 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:47:51 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:47:51 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:47:51 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:47:51 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:47:51 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:51 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:47:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:51 INFO - https://queue.taskcluster.net/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:47:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:47:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:47:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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 14:47:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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 14:47:54 INFO - Downloaded 22008941 bytes. 14:47:54 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'] 14:47:54 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 14:47:55 INFO - Return code: 0 14:47:55 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 14:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:55 INFO - https://queue.taskcluster.net/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:47:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:47:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:47:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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 14:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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 14:47:57 INFO - Downloaded 22008941 bytes. 14:47:57 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'] 14:47:57 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 14:47:58 INFO - Return code: 0 14:47:58 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')]} 14:47:58 INFO - https://queue.taskcluster.net/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:47:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:47:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:47:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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 14:47:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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 14:47:59 INFO - Downloaded 10846565 bytes. 14:47:59 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'] 14:47:59 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 14:47:59 INFO - Return code: 0 14:47: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')]} 14:47:59 INFO - https://queue.taskcluster.net/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:47:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:47:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:47:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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 14:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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 14:48:01 INFO - Downloaded 54151221 bytes. 14:48:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:48:01 INFO - mkdir: /builds/slave/test/properties 14:48:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:48:01 INFO - Writing to file /builds/slave/test/properties/build_url 14:48:01 INFO - Contents: 14:48:01 INFO - build_url:https://queue.taskcluster.net/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:48:02 INFO - Running post-action listener: _resource_record_post_action 14:48:02 INFO - Running post-action listener: set_extra_try_arguments 14:48:02 INFO - ##### 14:48:02 INFO - ##### Running populate-webroot step. 14:48:02 INFO - ##### 14:48:02 INFO - Running pre-action listener: _resource_record_pre_action 14:48:02 INFO - Running main action method: populate_webroot 14:48:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:48:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:48:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:48:02 INFO - '--tppagecycles', 14:48:02 INFO - '7'], 14:48:02 INFO - 'tests': ['tsvgm']}}, 14:48:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:48:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:48:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:48:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:48:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:48:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:48:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:02 INFO - 'talos_options': ['--e10s'], 14:48:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:02 INFO - 'tests': ['damp', 'tps']}, 14:48:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:02 INFO - 'talos_options': ['--e10s'], 14:48:02 INFO - 'tests': ['damp', 'tps']}, 14:48:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:48:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:48:02 INFO - 'other': {'tests': ['a11yr', 14:48:02 INFO - 'ts_paint', 14:48:02 INFO - 'tpaint', 14:48:02 INFO - 'sessionrestore', 14:48:02 INFO - 'sessionrestore_no_auto_restore', 14:48:02 INFO - 'tabpaint']}, 14:48:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:48:02 INFO - 'tests': ['a11yr', 14:48:02 INFO - 'ts_paint', 14:48:02 INFO - 'tpaint', 14:48:02 INFO - 'sessionrestore', 14:48:02 INFO - 'sessionrestore_no_auto_restore', 14:48:02 INFO - 'tabpaint']}, 14:48:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:48:02 INFO - 'tests': ['a11yr', 14:48:02 INFO - 'ts_paint', 14:48:02 INFO - 'tpaint', 14:48:02 INFO - 'sessionrestore', 14:48:02 INFO - 'sessionrestore_no_auto_restore', 14:48:02 INFO - 'tabpaint']}, 14:48:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:48:02 INFO - 'tests': ['a11yr', 14:48:02 INFO - 'ts_paint', 14:48:02 INFO - 'tpaint', 14:48:02 INFO - 'sessionrestore', 14:48:02 INFO - 'sessionrestore_no_auto_restore', 14:48:02 INFO - 'tabpaint']}, 14:48:02 INFO - 'other_l64': {'tests': ['a11yr', 14:48:02 INFO - 'ts_paint', 14:48:02 INFO - 'tpaint', 14:48:02 INFO - 'sessionrestore', 14:48:02 INFO - 'sessionrestore_no_auto_restore', 14:48:02 INFO - 'tabpaint']}, 14:48:02 INFO - 'other_nol64': {'tests': ['a11yr', 14:48:02 INFO - 'ts_paint', 14:48:02 INFO - 'tpaint', 14:48:02 INFO - 'sessionrestore', 14:48:02 INFO - 'sessionrestore_no_auto_restore', 14:48:02 INFO - 'tabpaint']}, 14:48:02 INFO - 'svgr': {'tests': ['tsvgx', 14:48:02 INFO - 'tsvgr_opacity', 14:48:02 INFO - 'tart', 14:48:02 INFO - 'tscrollx', 14:48:02 INFO - 'cart']}, 14:48:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:48:02 INFO - 'tests': ['tsvgx', 14:48:02 INFO - 'tsvgr_opacity', 14:48:02 INFO - 'tart', 14:48:02 INFO - 'tscrollx', 14:48:02 INFO - 'cart']}, 14:48:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:02 INFO - 'tests': ['tp5o']}, 14:48:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:02 INFO - 'talos_options': ['--e10s'], 14:48:02 INFO - 'tests': ['tp5o']}, 14:48:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:02 INFO - 'talos_options': ['--xperf_path', 14:48:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:02 INFO - 'tests': ['tp5n']}, 14:48:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:48:02 INFO - 'talos_options': ['--e10s', 14:48:02 INFO - '--xperf_path', 14:48:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:02 INFO - 'tests': ['tp5n']}}, 14:48:02 INFO - 'talos.zip': {'path': '', 14:48:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:48:02 INFO - Running post-action listener: _resource_record_post_action 14:48:02 INFO - ##### 14:48:02 INFO - ##### Running create-virtualenv step. 14:48:02 INFO - ##### 14:48:02 INFO - Running pre-action listener: _resource_record_pre_action 14:48:02 INFO - Running main action method: create_virtualenv 14:48:02 INFO - Creating virtualenv /builds/slave/test/build/venv 14:48:02 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 14:48:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:48:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:48:02 INFO - Using real prefix '/usr' 14:48:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:48:02 INFO - Installing distribute.............................................................................................................................................................................................done. 14:48:04 INFO - Installing pip.................done. 14:48:04 INFO - Return code: 0 14:48:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:04 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 0x7fd3e3b19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050410>, '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 0x1051310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10517a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', '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 14:48:04 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 14:48:04 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 14:48:04 INFO - Using env: {'DISPLAY': ':0', 14:48:04 INFO - 'HOME': '/home/cltbld', 14:48:04 INFO - 'LANG': 'en_US.UTF-8', 14:48:04 INFO - 'LANGUAGE': 'en_US:en', 14:48:04 INFO - 'LOGNAME': 'cltbld', 14:48:04 INFO - 'MAIL': '/var/mail/cltbld', 14:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:04 INFO - 'MOZ_NO_REMOTE': '1', 14:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:04 INFO - 'NO_EM_RESTART': '1', 14:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:04 INFO - 'PWD': '/builds/slave/test', 14:48:04 INFO - 'SHELL': '/bin/bash', 14:48:04 INFO - 'SHLVL': '1', 14:48:04 INFO - 'TERM': 'linux', 14:48:04 INFO - 'TMOUT': '86400', 14:48:04 INFO - 'USER': 'cltbld', 14:48:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', 14:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:04 INFO - '_': '/tools/buildbot/bin/python'} 14:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:04 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 14:48:04 INFO - Cleaning up... 14:48:04 INFO - Return code: 0 14:48:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:04 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 0x7fd3e3b19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050410>, '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 0x1051310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10517a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', '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 14:48:04 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 14:48:04 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 14:48:04 INFO - Using env: {'DISPLAY': ':0', 14:48:04 INFO - 'HOME': '/home/cltbld', 14:48:04 INFO - 'LANG': 'en_US.UTF-8', 14:48:04 INFO - 'LANGUAGE': 'en_US:en', 14:48:04 INFO - 'LOGNAME': 'cltbld', 14:48:04 INFO - 'MAIL': '/var/mail/cltbld', 14:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:04 INFO - 'MOZ_NO_REMOTE': '1', 14:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:04 INFO - 'NO_EM_RESTART': '1', 14:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:04 INFO - 'PWD': '/builds/slave/test', 14:48:04 INFO - 'SHELL': '/bin/bash', 14:48:04 INFO - 'SHLVL': '1', 14:48:04 INFO - 'TERM': 'linux', 14:48:04 INFO - 'TMOUT': '86400', 14:48:04 INFO - 'USER': 'cltbld', 14:48:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', 14:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:04 INFO - '_': '/tools/buildbot/bin/python'} 14:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:05 INFO - Downloading/unpacking psutil>=0.7.1 14:48: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 14:48: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 14:48: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 14:48: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 14:48: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 14:48: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 14:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:48:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:07 INFO - Installing collected packages: psutil 14:48:07 INFO - Running setup.py install for psutil 14:48:07 INFO - building 'psutil._psutil_linux' extension 14:48:07 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 14:48:07 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 14:48:07 INFO - building 'psutil._psutil_posix' extension 14:48:07 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 14:48:07 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 14:48:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:07 INFO - Successfully installed psutil 14:48:07 INFO - Cleaning up... 14:48:07 INFO - Return code: 0 14:48:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd3e3b19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050410>, '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 0x1051310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10517a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', '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 14:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:48:07 INFO - Using env: {'DISPLAY': ':0', 14:48:07 INFO - 'HOME': '/home/cltbld', 14:48:07 INFO - 'LANG': 'en_US.UTF-8', 14:48:07 INFO - 'LANGUAGE': 'en_US:en', 14:48:07 INFO - 'LOGNAME': 'cltbld', 14:48:07 INFO - 'MAIL': '/var/mail/cltbld', 14:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:07 INFO - 'MOZ_NO_REMOTE': '1', 14:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:07 INFO - 'NO_EM_RESTART': '1', 14:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:07 INFO - 'PWD': '/builds/slave/test', 14:48:07 INFO - 'SHELL': '/bin/bash', 14:48:07 INFO - 'SHLVL': '1', 14:48:07 INFO - 'TERM': 'linux', 14:48:07 INFO - 'TMOUT': '86400', 14:48:07 INFO - 'USER': 'cltbld', 14:48:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', 14:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:07 INFO - '_': '/tools/buildbot/bin/python'} 14:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:48:09 INFO - Installing collected packages: mozsystemmonitor 14:48:09 INFO - Running setup.py install for mozsystemmonitor 14:48:09 INFO - Successfully installed mozsystemmonitor 14:48:09 INFO - Cleaning up... 14:48:09 INFO - Return code: 0 14:48:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd3e3b19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050410>, '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 0x1051310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10517a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', '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 14:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:48:09 INFO - Using env: {'DISPLAY': ':0', 14:48:09 INFO - 'HOME': '/home/cltbld', 14:48:09 INFO - 'LANG': 'en_US.UTF-8', 14:48:09 INFO - 'LANGUAGE': 'en_US:en', 14:48:09 INFO - 'LOGNAME': 'cltbld', 14:48:09 INFO - 'MAIL': '/var/mail/cltbld', 14:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:09 INFO - 'MOZ_NO_REMOTE': '1', 14:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:09 INFO - 'NO_EM_RESTART': '1', 14:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:09 INFO - 'PWD': '/builds/slave/test', 14:48:09 INFO - 'SHELL': '/bin/bash', 14:48:09 INFO - 'SHLVL': '1', 14:48:09 INFO - 'TERM': 'linux', 14:48:09 INFO - 'TMOUT': '86400', 14:48:09 INFO - 'USER': 'cltbld', 14:48:09 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', 14:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:09 INFO - '_': '/tools/buildbot/bin/python'} 14:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:10 INFO - Downloading/unpacking blobuploader==1.2.4 14:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:11 INFO - Downloading blobuploader-1.2.4.tar.gz 14:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:48:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:48:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:12 INFO - Downloading docopt-0.6.1.tar.gz 14:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:48:12 INFO - Installing collected packages: blobuploader, requests, docopt 14:48:12 INFO - Running setup.py install for blobuploader 14:48:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:48:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:48:12 INFO - Running setup.py install for requests 14:48:13 INFO - Running setup.py install for docopt 14:48:13 INFO - Successfully installed blobuploader requests docopt 14:48:13 INFO - Cleaning up... 14:48:13 INFO - Return code: 0 14:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48: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')]} 14:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:13 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 0x7fd3e3b19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050410>, '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 0x1051310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10517a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', '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 14:48:13 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 14:48:13 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 14:48:13 INFO - Using env: {'DISPLAY': ':0', 14:48:13 INFO - 'HOME': '/home/cltbld', 14:48:13 INFO - 'LANG': 'en_US.UTF-8', 14:48:13 INFO - 'LANGUAGE': 'en_US:en', 14:48:13 INFO - 'LOGNAME': 'cltbld', 14:48:13 INFO - 'MAIL': '/var/mail/cltbld', 14:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:13 INFO - 'MOZ_NO_REMOTE': '1', 14:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:13 INFO - 'NO_EM_RESTART': '1', 14:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:13 INFO - 'PWD': '/builds/slave/test', 14:48:13 INFO - 'SHELL': '/bin/bash', 14:48:13 INFO - 'SHLVL': '1', 14:48:13 INFO - 'TERM': 'linux', 14:48:13 INFO - 'TMOUT': '86400', 14:48:13 INFO - 'USER': 'cltbld', 14:48:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', 14:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:13 INFO - '_': '/tools/buildbot/bin/python'} 14:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:13 INFO - Running setup.py (path:/tmp/pip-4YS2Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:13 INFO - Running setup.py (path:/tmp/pip-5OHHu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:13 INFO - Running setup.py (path:/tmp/pip-4X8JxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:13 INFO - Running setup.py (path:/tmp/pip-Yu9_Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:13 INFO - Running setup.py (path:/tmp/pip-8X7AdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:13 INFO - Running setup.py (path:/tmp/pip-VKxUMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:13 INFO - Running setup.py (path:/tmp/pip-bIjnP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:14 INFO - Running setup.py (path:/tmp/pip-qfhUrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:14 INFO - Running setup.py (path:/tmp/pip-PfuW1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:14 INFO - Running setup.py (path:/tmp/pip-nI3ikp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:14 INFO - Running setup.py (path:/tmp/pip-j63yfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:14 INFO - Running setup.py (path:/tmp/pip-b5PZdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:14 INFO - Running setup.py (path:/tmp/pip-i1tAva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:14 INFO - Running setup.py (path:/tmp/pip-SLT9mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:14 INFO - Running setup.py (path:/tmp/pip-zKQrnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:14 INFO - Running setup.py (path:/tmp/pip-j0JZkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:14 INFO - Running setup.py (path:/tmp/pip-70YibQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:48:14 INFO - Running setup.py install for manifestparser 14:48:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:48:14 INFO - Running setup.py install for mozcrash 14:48:14 INFO - Running setup.py install for mozdebug 14:48:15 INFO - Running setup.py install for mozdevice 14:48:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozfile 14:48:15 INFO - Running setup.py install for mozhttpd 14:48:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozinfo 14:48:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozInstall 14:48:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozleak 14:48:15 INFO - Running setup.py install for mozlog 14:48:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for moznetwork 14:48:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozprocess 14:48:15 INFO - Running setup.py install for mozprofile 14:48:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Running setup.py install for mozrunner 14:48:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Running setup.py install for mozscreenshot 14:48:16 INFO - Running setup.py install for moztest 14:48:16 INFO - Running setup.py install for mozversion 14:48:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:48:16 INFO - Cleaning up... 14:48:16 INFO - Return code: 0 14:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:16 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')]} 14:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:16 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')]} 14:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:16 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 0x7fd3e3b19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050410>, '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 0x1051310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10517a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', '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 14:48:16 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 14:48:16 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 14:48:16 INFO - Using env: {'DISPLAY': ':0', 14:48:16 INFO - 'HOME': '/home/cltbld', 14:48:16 INFO - 'LANG': 'en_US.UTF-8', 14:48:16 INFO - 'LANGUAGE': 'en_US:en', 14:48:16 INFO - 'LOGNAME': 'cltbld', 14:48:16 INFO - 'MAIL': '/var/mail/cltbld', 14:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:16 INFO - 'MOZ_NO_REMOTE': '1', 14:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:16 INFO - 'NO_EM_RESTART': '1', 14:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:16 INFO - 'PWD': '/builds/slave/test', 14:48:16 INFO - 'SHELL': '/bin/bash', 14:48:16 INFO - 'SHLVL': '1', 14:48:16 INFO - 'TERM': 'linux', 14:48:16 INFO - 'TMOUT': '86400', 14:48:16 INFO - 'USER': 'cltbld', 14:48:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', 14:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:16 INFO - '_': '/tools/buildbot/bin/python'} 14:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:16 INFO - Running setup.py (path:/tmp/pip-iSRiQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:16 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)) 14:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:16 INFO - Running setup.py (path:/tmp/pip-H37K3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:16 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)) 14:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:16 INFO - Running setup.py (path:/tmp/pip-P0CFRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:16 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)) 14:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:16 INFO - Running setup.py (path:/tmp/pip-qcL3py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:17 INFO - Running setup.py (path:/tmp/pip-8aE8sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:17 INFO - Running setup.py (path:/tmp/pip-sqCAyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:17 INFO - Running setup.py (path:/tmp/pip-Oq_GWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:17 INFO - Running setup.py (path:/tmp/pip-tlpi84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:17 INFO - Running setup.py (path:/tmp/pip-aEQmeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:17 INFO - Running setup.py (path:/tmp/pip-IPef4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:17 INFO - Running setup.py (path:/tmp/pip-Kvkjx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:17 INFO - Running setup.py (path:/tmp/pip-UtTVlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:17 INFO - Running setup.py (path:/tmp/pip-6ZZO7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:17 INFO - Running setup.py (path:/tmp/pip-CRWaeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:17 INFO - Running setup.py (path:/tmp/pip-sKythh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:17 INFO - Running setup.py (path:/tmp/pip-TT_fIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:17 INFO - Running setup.py (path:/tmp/pip-IoBqfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:17 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)) 14:48:17 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)) 14:48:17 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)) 14:48:17 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)) 14:48:17 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)) 14:48:17 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)) 14:48:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:19 INFO - Downloading blessings-1.6.tar.gz 14:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:48:19 INFO - Installing collected packages: blessings 14:48:19 INFO - Running setup.py install for blessings 14:48:20 INFO - Successfully installed blessings 14:48:20 INFO - Cleaning up... 14:48:20 INFO - Return code: 0 14:48:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:20 INFO - Reading from file tmpfile_stdout 14:48:20 INFO - Current package versions: 14:48:20 INFO - argparse == 1.2.1 14:48:20 INFO - blessings == 1.6 14:48:20 INFO - blobuploader == 1.2.4 14:48:20 INFO - docopt == 0.6.1 14:48:20 INFO - manifestparser == 1.1 14:48:20 INFO - mozInstall == 1.12 14:48:20 INFO - mozcrash == 0.17 14:48:20 INFO - mozdebug == 0.1 14:48:20 INFO - mozdevice == 0.48 14:48:20 INFO - mozfile == 1.2 14:48:20 INFO - mozhttpd == 0.7 14:48:20 INFO - mozinfo == 0.9 14:48:20 INFO - mozleak == 0.1 14:48:20 INFO - mozlog == 3.1 14:48:20 INFO - moznetwork == 0.27 14:48:20 INFO - mozprocess == 0.22 14:48:20 INFO - mozprofile == 0.28 14:48:20 INFO - mozrunner == 6.11 14:48:20 INFO - mozscreenshot == 0.1 14:48:20 INFO - mozsystemmonitor == 0.0 14:48:20 INFO - moztest == 0.7 14:48:20 INFO - mozversion == 1.4 14:48:20 INFO - psutil == 3.1.1 14:48:20 INFO - requests == 1.2.3 14:48:20 INFO - wsgiref == 0.1.2 14:48:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:20 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 0x7fd3e3b19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050410>, '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 0x1051310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10517a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', '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 14:48:20 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 14:48:20 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 14:48:20 INFO - Using env: {'DISPLAY': ':0', 14:48:20 INFO - 'HOME': '/home/cltbld', 14:48:20 INFO - 'LANG': 'en_US.UTF-8', 14:48:20 INFO - 'LANGUAGE': 'en_US:en', 14:48:20 INFO - 'LOGNAME': 'cltbld', 14:48:20 INFO - 'MAIL': '/var/mail/cltbld', 14:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:20 INFO - 'MOZ_NO_REMOTE': '1', 14:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:20 INFO - 'NO_EM_RESTART': '1', 14:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:20 INFO - 'PWD': '/builds/slave/test', 14:48:20 INFO - 'SHELL': '/bin/bash', 14:48:20 INFO - 'SHLVL': '1', 14:48:20 INFO - 'TERM': 'linux', 14:48:20 INFO - 'TMOUT': '86400', 14:48:20 INFO - 'USER': 'cltbld', 14:48:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', 14:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:20 INFO - '_': '/tools/buildbot/bin/python'} 14:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 INFO - Cleaning up... 14:48:20 INFO - Return code: 0 14:48:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:20 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 0x7fd3e3b19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050410>, '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 0x1051310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10517a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', '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 14:48:20 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 14:48:20 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 14:48:20 INFO - Using env: {'DISPLAY': ':0', 14:48:20 INFO - 'HOME': '/home/cltbld', 14:48:20 INFO - 'LANG': 'en_US.UTF-8', 14:48:20 INFO - 'LANGUAGE': 'en_US:en', 14:48:20 INFO - 'LOGNAME': 'cltbld', 14:48:20 INFO - 'MAIL': '/var/mail/cltbld', 14:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:20 INFO - 'MOZ_NO_REMOTE': '1', 14:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:20 INFO - 'NO_EM_RESTART': '1', 14:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:20 INFO - 'PWD': '/builds/slave/test', 14:48:20 INFO - 'SHELL': '/bin/bash', 14:48:20 INFO - 'SHLVL': '1', 14:48:20 INFO - 'TERM': 'linux', 14:48:20 INFO - 'TMOUT': '86400', 14:48:20 INFO - 'USER': 'cltbld', 14:48:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', 14:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:20 INFO - '_': '/tools/buildbot/bin/python'} 14:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:20 INFO - Downloading/unpacking jsonschema 14:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:48:22 INFO - Downloading/unpacking functools32 (from jsonschema) 14:48:22 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 14:48:22 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 14:48:22 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 14:48:22 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 14:48:22 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 14:48:22 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 14:48:22 INFO - Downloading functools32-3.2.3-2.tar.gz 14:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:48:22 INFO - warning: no files found matching '*.txt' 14:48:22 INFO - no previously-included directories found matching 'build' 14:48:22 INFO - no previously-included directories found matching 'dist' 14:48:22 INFO - no previously-included directories found matching '.git*' 14:48:22 INFO - Installing collected packages: jsonschema, functools32 14:48:22 INFO - Running setup.py install for functools32 14:48:22 INFO - warning: no files found matching '*.txt' 14:48:22 INFO - no previously-included directories found matching 'build' 14:48:22 INFO - no previously-included directories found matching 'dist' 14:48:22 INFO - no previously-included directories found matching '.git*' 14:48:22 INFO - Successfully installed jsonschema functools32 14:48:22 INFO - Cleaning up... 14:48:23 INFO - Return code: 0 14:48:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 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 0x7fd3e3b19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050410>, '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 0x1051310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10517a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', '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 14:48:23 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 14:48:23 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 14:48:23 INFO - Using env: {'DISPLAY': ':0', 14:48:23 INFO - 'HOME': '/home/cltbld', 14:48:23 INFO - 'LANG': 'en_US.UTF-8', 14:48:23 INFO - 'LANGUAGE': 'en_US:en', 14:48:23 INFO - 'LOGNAME': 'cltbld', 14:48:23 INFO - 'MAIL': '/var/mail/cltbld', 14:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:23 INFO - 'MOZ_NO_REMOTE': '1', 14:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:23 INFO - 'NO_EM_RESTART': '1', 14:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:23 INFO - 'PWD': '/builds/slave/test', 14:48:23 INFO - 'SHELL': '/bin/bash', 14:48:23 INFO - 'SHLVL': '1', 14:48:23 INFO - 'TERM': 'linux', 14:48:23 INFO - 'TMOUT': '86400', 14:48:23 INFO - 'USER': 'cltbld', 14:48:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', 14:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:23 INFO - '_': '/tools/buildbot/bin/python'} 14:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:23 INFO - Downloading/unpacking flake8 14:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:48:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:48:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:48:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:48:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:48:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:48:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:48:25 INFO - no previously-included directories found matching 'docs/_build' 14:48:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:48:25 INFO - Running setup.py install for pep8 14:48:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:48:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:48:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:48:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:48:25 INFO - no previously-included directories found matching 'docs/_build' 14:48:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:48:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:48:25 INFO - Cleaning up... 14:48:25 INFO - Return code: 0 14:48:25 INFO - Running post-action listener: _resource_record_post_action 14:48:25 INFO - Running post-action listener: _start_resource_monitoring 14:48:26 INFO - Starting resource monitoring. 14:48:26 INFO - ##### 14:48:26 INFO - ##### Running install step. 14:48:26 INFO - ##### 14:48:26 INFO - Running pre-action listener: _resource_record_pre_action 14:48:26 INFO - Running main action method: install 14:48:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:26 INFO - Reading from file tmpfile_stdout 14:48:26 INFO - Detecting whether we're running mozinstall >=1.0... 14:48:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:48:26 INFO - Reading from file tmpfile_stdout 14:48:26 INFO - Output received: 14:48:26 INFO - Usage: mozinstall [options] installer 14:48:26 INFO - Options: 14:48:26 INFO - -h, --help show this help message and exit 14:48:26 INFO - -d DEST, --destination=DEST 14:48:26 INFO - Directory to install application into. [default: 14:48:26 INFO - "/builds/slave/test"] 14:48:26 INFO - --app=APP Application being installed. [default: firefox] 14:48:26 INFO - mkdir: /builds/slave/test/build/application 14:48:26 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'] 14:48:26 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 14:48:41 INFO - Reading from file tmpfile_stdout 14:48:41 INFO - Output received: 14:48:41 INFO - /builds/slave/test/build/application/firefox/firefox 14:48:41 INFO - Running post-action listener: _resource_record_post_action 14:48:41 INFO - ##### 14:48:41 INFO - ##### Running run-tests step. 14:48:41 INFO - ##### 14:48:41 INFO - Running pre-action listener: _resource_record_pre_action 14:48:41 INFO - Running main action method: run_tests 14:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:48:41 INFO - Python 2.7.3 14:48:41 INFO - Return code: 0 14:48:41 INFO - grabbing minidump binary from tooltool 14:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:41 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 0x1050410>, '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 0x1051310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10517a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:48:41 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 14:48:42 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 14:48:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:48:42 INFO - Return code: 0 14:48:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:48:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:48:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:48:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:48:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:48:43 INFO - Return code: 0 14:48:43 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/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 14:48:43 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/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 14:48:43 INFO - Using env: {'DISPLAY': ':0', 14:48:43 INFO - 'HOME': '/home/cltbld', 14:48:43 INFO - 'LANG': 'en_US.UTF-8', 14:48:43 INFO - 'LANGUAGE': 'en_US:en', 14:48:43 INFO - 'LOGNAME': 'cltbld', 14:48:43 INFO - 'MAIL': '/var/mail/cltbld', 14:48:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:48:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:43 INFO - 'MOZ_NO_REMOTE': '1', 14:48:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:43 INFO - 'NO_EM_RESTART': '1', 14:48:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:43 INFO - 'PWD': '/builds/slave/test', 14:48:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:48:43 INFO - 'SHELL': '/bin/bash', 14:48:43 INFO - 'SHLVL': '1', 14:48:43 INFO - 'TERM': 'linux', 14:48:43 INFO - 'TMOUT': '86400', 14:48:43 INFO - 'USER': 'cltbld', 14:48:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687', 14:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:43 INFO - '_': '/tools/buildbot/bin/python'} 14:48:43 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/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 14:48:43 INFO - mozversion application_buildid: 20160317141822 14:48:43 INFO - mozversion application_changeset: 1477dcbfb8ec44166c93473932a475a3c4dec17f 14:48:43 INFO - mozversion application_display_name: Nightly 14:48:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:48:43 INFO - mozversion application_name: Firefox 14:48:43 INFO - mozversion application_remotingname: firefox 14:48:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:48:43 INFO - mozversion application_vendor: Mozilla 14:48:43 INFO - mozversion application_version: 48.0a1 14:48:43 INFO - mozversion platform_buildid: 20160317141822 14:48:43 INFO - mozversion platform_changeset: 1477dcbfb8ec44166c93473932a475a3c4dec17f 14:48:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:48:43 INFO - mozversion platform_version: 48.0a1 14:48:43 INFO - using testdate: 1458251323 14:48:43 INFO - actual date: 1458251323 14:48:43 INFO - starting webserver on 'localhost:40644' 14:48:43 INFO - SUITE-START | Running 2 tests 14:48:43 INFO - TEST-START | dromaeo_css 14:48:43 INFO - operating with platform_type : linux_ 14:48:43 INFO - Initialising browser for dromaeo_css test... 14:48:43 INFO - TEST-INFO | started process 16499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSRVHbM/profile http://localhost:40644/getInfo.html) 14:48:47 INFO - PROCESS | 16499 | __metrics Screen width/height:1600/1200 14:48:47 INFO - PROCESS | 16499 | colorDepth:24 14:48:47 INFO - PROCESS | 16499 | Browser inner width/height: 1024/697 14:48:47 INFO - PROCESS | 16499 | __metrics 14:48:48 ERROR - PROCESS | 16499 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:48:49 INFO - TEST-INFO | 16499: exit 0 14:48:49 INFO - Browser initialized. 14:48:49 INFO - Running cycle 1/1 for dromaeo_css test... 14:48:49 INFO - TEST-INFO | started process 16590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSRVHbM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:49:01 INFO - PROCESS | 16590 | RSS: Main: 154550272 14:49:01 INFO - PROCESS | 16590 | 14:49:52 INFO - PROCESS | 16590 | 1458251392573 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] 14:52:03 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:40644/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40644/tests/dromaeo/cssquery-ext.html) 14:52:04 INFO - PROCESS | 16590 | RSS: Main: 245141504 14:52:04 INFO - PROCESS | 16590 | 14:55:07 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:40644/tests/dromaeo/cssquery-ext.html (next: http://localhost:40644/tests/dromaeo/cssquery-jquery.html) 14:55:07 INFO - PROCESS | 16590 | RSS: Main: 237326336 14:55:07 INFO - PROCESS | 16590 | 14:58:09 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:40644/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40644/tests/dromaeo/cssquery-mootools.html) 14:58:10 INFO - PROCESS | 16590 | RSS: Main: 232964096 14:58:10 INFO - PROCESS | 16590 | 15:01:12 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:40644/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40644/tests/dromaeo/cssquery-prototype.html) 15:01:12 INFO - PROCESS | 16590 | RSS: Main: 215662592 15:01:12 INFO - PROCESS | 16590 | 15:04:15 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:40644/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40644/tests/dromaeo/cssquery-yui.html) 15:04:16 INFO - PROCESS | 16590 | RSS: Main: 203276288 15:04:16 INFO - PROCESS | 16590 | 15:07:18 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:40644/tests/dromaeo/cssquery-yui.html (next: http://localhost:40644/tests/dromaeo/cssquery-dojo.html) 15:07:19 INFO - PROCESS | 16590 | RSS: Main: 268898304 15:07:19 INFO - PROCESS | 16590 | 15:07:19 INFO - PROCESS | 16590 | __start_tp_report 15:07:19 INFO - PROCESS | 16590 | _x_x_mozilla_page_load 15:07:19 INFO - PROCESS | 16590 | _x_x_mozilla_page_load_details 15:07:19 INFO - PROCESS | 16590 | |i|pagename|runs| 15:07:19 INFO - PROCESS | 16590 | |0;dojo.html;2594.26063571882;2688.3816722153906;2697.716739742328;2711.2815103997445;2722.8366298022115;4593.701409408394;4667.743274119922;4673.158831410345;4702.9529704702945;4721.10299043182;4667.649926255536;4700.012997270577;4707.952920470802;4709.364235828162;4716.905661886769;4294.788184085183;4377.846775362863;4412.249917514015;4466.955330446686;4469.7541635210055;4182.184474027566;4357.38996540483;4423;4433.467983841943;4445.355423463596;4068.2677118118727;4282.635975942048;4295.656347492209;4355.085432059272;4380.408644832971;4291.527931927485;4308.46144231971;4311.267084595626;4345.304751239786;4352.8476503322545;4143.1713657268665;4301.526832048472;4302.397664326997;4308.633766129883;4359.280718681413;4567.680262381635;4626.653001024936;4648.814047438098;4674.298855171717;4691.577758001762;5028.321176641143;5033.119204139261;5042.243663450475;5048.7728052237735;5077.466865979056;4994.350734404504;5034.395872495287;5039.395272567279;5049.065922804256;5055.696658200483;4755.286706993978;4770.069836381942;4772.117158325721;4790.784414701347;4818.68678535894;5206.427292997767;5218.7912483500995;5224.791008359623;5225.6603320784025;5274.077036518671;4797.088553174885;4927.605791536668;4996.900061998813;5006.974965125151;5022.974885125551;5077.593792496591;5082.771275292621;5100.2349647553165;5109.565686916654;5122.385313762373;5048.949510504848;5050.419201791768;5051.292819005343;5051.924221136685;5086.109930762102;4820.3492528508905;4938.925916111261;5024.422191447957;5043.773030213649;5053.36832895888;4257.829686812554;4262.211490874198;4273.87178384649;4275.508316543575;4321.222180007566;3755.511783468132;3757.192203676168;3764.9058773530332;3768.660820526111;3803.201327721154;4290.313549832012;4336.306191009423;4363.585459381354;4400;4411.801468933906;5044.117279476077;5066.08810414129;5066.442691303953;5103.489651034867;5135.178371460548;4360.236958532244;4374.540673229265;4375.912481750347;4379.1022840317655;4423.623991960655;4394.252976993918;4499.055198408306;4541.455025396907;4559.886002849889;4605.4933957264675;4800.231962885921;4804.135255653946;4815.6147508199965;4817.518248175154;4871.464138944642;4899.510048995072;5042.621803364836;5049.495050494921;5055.51972562606;5102.285680004877;4707.529247075402;4756.9762151189025;4778.354922085474;4821.083994041121;4822.662413631012;4961.404631444249;5003.499650034967;5009.5491405773655;5010.448850626501;5046.646734728533;4878.463369029475;4910.607151427806;5078.949210507848;5098.617603679813;5151.587872970228;4912.091263116335;4924.655274130777;4928.630352723489;4928.852134435972;4978.47725988766;4905.313256144072;4928.186849169847;4930.556249937379;4932.284818701197;4974.0797952378925;4745.932165262789;4767.451743049455;4843.6367272454;4883.487233840396;4911.877203069952;4925.113479573711;4936.111499929903;4941.456439791692;4969.503049695001;4998.6750861193905;4818.903621927471;4824.059308434821;4838.2016967201425;4844.95155048445;4891.388576427947 15:07:19 INFO - PROCESS | 16590 | |1;ext.html;527.2934268080771;532.5499952540104;556.8663520755017;557.7350758389765;596.9134475501049;27431.314217144558;27939;34723.13192170197;35021.474677879785;35136.82431587839;38709;39034.609653903455;39076.80461597688;39128.41307380392;39218.215635687266;7667.079950405945;7853.175416581234;7855;7856.450048496607;7858.8821167682245;7700.383969282444;7780.221977802203;7788.260115289038;7833.177516360785;7840.059192896861;7783.688652453923;7858.921410785904;8017.478863873858;8035.477693949903;8038.155993620673;7929.207079292053;8001;8001.759947201594;8010.078840933309;8010.759677209693;7888.684452621888;8014.2787149156275;8019.879701804478;8021.117677055519;8024.598770061473;39197.608023919965;39607;39720.80139599313;39736.60263397387;39749;2875.7699384049224;3152.021339833858;3281.212508997847;3690.464882592036;3773.754705944105;29828.70171298281;29875;29909.102726918227;30018;30512.69487305121;3249.333886553251;3258.560094387251;3288.2765791525826;3289.6381398046196;3321.2693207494312;232316;233072;233362;233668.47486438585;234438;43745.906352341444;44446.33330500045;44451.333230001575;56614.7169264151;56868.71565642145;42266.15467690629;42289;42456;42500.78749606294;42529.787351063045;13682.247476388695;13730.862691372959;13812.37844297009;13829.10110842792;13837.792433113511;10776.407297598707;10844.349339039683;10859.457027148612;10866.836997445045;10868;14933.925330373278;14942.402303907722;15071.54785356441;15119.924400377928;15229;5841.9415805842245;6009;6057.637031667839;6066.332703402622;6124.418180272867;747.9738209162654;838.8238469921263;870.8171284030425;907.6598118922429;1065.8028264771042;27018.864905675346;27756.861215693792;28304.71695283062;28578.142655720363;28581;979.4857699707568;1006.8942761010135;1120.5517792882913;1135.9886401136048;1142.8400023996646;14235;14666.266686665624;14765.187914664582;14972.326245318987;15041.924790375979;300775;303378;305017;305747;306994;47682;48316.758416208395;48338.274925875434;48398;48439.757801211475;1061.3790932304535;1219.878012198773;1237.9442925068574;1242.0746543824907;1359.16411406984;25080.498390032462;27079;27732.168034958984;28164.85917570399;28171.154865354074;36407.45388819117;36785.81607092055;37301.0674733123;37419.251614967005;37470.43794343142;176972.1151394235;178827.10586446984;180786;186630;254898;34041.31917361589;34313.828430857684;34803.651963481054;35000.64999349974;35330.47004294989;40071.39892901551;40503.79748101241;44565.10869782651;46217;46338.53661463342;34075.31849362949;34593.48109778305;35275.118122047155;35351.646483535864;35792.28415431729;35112.47331289982;35236.47145292874;35536.46695299624;35569.28861422809;35760;34826.47760283649;35597.644023559435;35769;35968.64031359653;36040.8197959019;30912;31282.68717312889;31746.841265793522;31785.523217151298;31809;24348.269551913472;24830.50338993174;24998.87509561635;25380.238592842245;25422.110226141995 15:07:19 INFO - PROCESS | 16590 | |2;jquery.html;355.46325049175744;359.9082234030322;361.6835269139503;370.85721997031135;372.4878292348021;15445;15766.369345226192;16223.351065957348;16426.17869106546;16604.335826566952;15703;15884.285207165676;17222.224999875005;17229;17240.137993100358;4830.637702172334;4897.583705385037;5048.697078175322;5060.54455099041;5061.493850614946;5018.422881368653;5029.2958985742025;5053.36832895888;5058.620603454738;5063.797448102072;4948.38145231846;5011.624128190382;5034.899302013958;5037.395512538482;5048.29323894655;5209.348831396075;5210.270562121306;5246.422893481714;5278.498542638443;5283.260343551887;5010.72441015744;5047.545720885101;5048.990201959586;5067.949320506785;5079.161938280179;11696.47365868538;11808.173427860052;11981.700457488545;12004.939975300154;12019;1860.8927688025603;1925.7785354684252;2162.362103179566;2172.9891350543303;2236.4073520517077;8995;9060.275177985744;9089.136532029446;9208.12522810332;9350.205232555241;1792.937247196355;1815.5279627296866;1843.502254391307;1844.4927644897625;1855.0631930874956;41427.378589320884;53509.1973620396;54928.450715492734;60381.6980915097;62340.99999999955;9286.096350248317;10275.537600807982;10324.432156231329;10443;10608.204384671026;11982.34097124649;12150.088743344108;12155.635330940086;12174.57388991381;12311.50753969849;5684.971575142098;5770.798022069292;6751.831204219836;7322.4276603019825;7341.816454588571;7149.571025738473;7167.677454514559;7237.963810180915;7261.89107163393;7291.598962057032;4302.290122129876;4417.491988421309;4502.797374118107;4541.114482675913;4557.225271703818;1754.561359660085;1795.1383335998532;1818.6544556534216;1873.9156737946826;1876.8310852023383;767.8042099264763;812.9309008734324;853.6500034985626;865.8008658008694;948.7485816258697;15464.381424742884;15967.69276135943;16211.918940405223;16413.753793693104;16516.75224871628;848.4612271207827;865.182402629509;868.847951608466;887.924526415249;898.6270697660528;9109.68116115946;9261.536923153815;9408.247340212767;9467.479288639053;9557.569909354095;428934;430990;432511;437876;438805;71765.64117179485;74594;77432.61283693546;77436.61281693555;77639.61180194063;962.1821451765943;971.0629242780609;986.068165583531;996.7159359582339;997.3816233935007;14811.777823332874;15005.549833505012;15074;15227.162506062274;15457.5362739118;24861;25999.480010400064;34050.31899362049;34405.59160858716;34933.65066349304;41530.58469415267;44355.55644443514;45587;45667.31499027584;45962.54037459716;7428.554286742813;7466.104067511933;7517.812054698677;7749.961250193713;7764;9097.454152750855;11710.297382157098;11843.822342665038;11858.11064170208;11880.643580692593;10361.430121343097;10466.319689220481;10490.52792624349;10659.733506662396;10673.8932610676;5318;7808.828675698691;9570.282228832726;9698.466584337646;10283.280170388001;9930.851037234303;10115.949420252851;10256.538455769658;10263.948680256552;10505.369677819355;7400.718439279828;7437.405007599271;7437.772767493303;7563.470557060953;7568.394528437601;9072.183503484453;9926.553305101432;9928.404295742279;10052.748681283027;10152.593896244067 15:07:19 INFO - PROCESS | 16590 | |3;mootools.html;1222.5720997650817;1412.611531828747;1428.621415324939;1551.612096975756;1752.0188694331168;7224.602646854428;7399.371053460449;7404.703811847533;7413.555186688803;7442.292982166692;7279.272072792718;7495.700171993128;7503.624818759054;7512.023436953202;7515.812104697386;1921.9423417297503;1978.9703154452695;2193.484531135182;2269.8524595901254;2291.8166546676225;2279.4985103277254;2301.551197516485;2301.861888286708;2302.3898666853297;2308.3882771065682;2221.688963545097;2244.057495851738;2261.298997310839;2274.283600665793;2283.337832028718;2194.7394183990514;2243.7083179186684;2244.62963611004;2248.820094392445;2270.5572413379396;2282.703248577691;2302.033146078651;2304.896279667419;2306.6540018997116;2308.6306191009357;7402;7483.775486735407;7493.887591686129;7498.775036748852;7506.17432082476;4673.252279635242;4798.520147985174;4802.35168252285;4807.134715751164;4809.663323567352;3037.3621539476735;3082.660907300195;3153.8896138635037;3159.273367125551;3171.7304029157317;992.5979978108877;997.0677416615488;999.3354419311149;1017.7685847434366;1034.953427095775;10603.734906627318;10606.416647084407;10612.257142000062;10612.62855800051;10625.309354891984;4276.48682158143;4345.304751239786;4403.713758605681;4425.048614547888;4442.4669039715445;9013;9036.8644470333;9056.50189239585;9068.274538036942;9076.636934522545;4746.976265118652;4766.547178018082;4773.260144677581;4775.928361074587;4777.259524773665;3638.199596088856;3713.925721485555;3745.1573395985683;4164.562720914321;4275.358696195595;3743.3074881147077;3783.1677031053123;3831.980840095782;3854.865079722252;3870.4194370844034;1221.4930803716359;1235.0736947289533;1243.1795015289865;1244.508419174439;1255.7488502299577;1182.5092586576645;1183.1599564309436;1192.1952681939656;1204.747003129335;1209.679434949739;6921.792346229621;7019.227884932653;7091.468139889529;7137.89293160603;7159.355657990805;470.4613217865525;480.6323162780476;484.1189035954529;484.5396872970692;485.74741134609803;5547.833564993057;5572.637778544382;5580.218769372291;5582.358028826656;5605.691686957257;9014.459132452073;9248.861267081;9479;9481.146696797321;9573.28200384974;9336.533173341442;9343.813123737624;9376.203022743006;9403.905960940303;9420.811583768424;7124.180719217253;7254.673539690727;7300.598467084255;7315.4147668186415;7315.8536829264185;6664;6686.1642294713165;6704.463642908653;6711.798646040626;6733;8155.673773049011;8252.546109964009;8321.500709957421;8336.29141522953;8381.706640267561;8520.10538893432;8626.870596940926;8638.78403039904;8667.696630617898;8668.436551624125;6483.254425740912;6550.83622909412;6616.239132499824;6624.436922861611;6626.171728533934;7379.077615298088;7383.852322953403;7399.18608953004;7401.48189626721;7407.481476296823;6588.110605068446;6698.296678848651;6705.262421133769;6777.93222067773;6858.725650973905;6501.44737697301;6512.381323774234;6562.8359291018105;6599.67001649906;6671.8999215010845;6674.098996635392;6728.932710673026;6732.192136943598;6780.186377634715;6788.422984046214;6250;6324.873502530016;6341.302456729848;6343.0485427186295;6345;6250.312465628868;6361.459275961595;6363.649999250086;6370.8088757337355;6384.297727249906 15:07:19 INFO - PROCESS | 16590 | |4;prototype.html;325.16108440224207;325.3217042466457;327.17714946908546;331.7163824929685;334.26295019482046;5363.919541206885;5413.918791218125;5417.34991800984;5420.403755586883;5423.511883930445;5354;5358.490943360384;5377.677339359631;5386.973065134669;5392.056390131721;3999.300122478569;4087.7547347159116;4138.317177665682;4186.56041115683;4194.832206711728;4201.6218540331365;4212.662986961036;4214.473190851144;4224.640905523019;4225.197212529625;4188.476440444944;4196.181744559812;4196.601322874322;4197.307444271692;4205.768682722449;4006.078601921545;4082.3672330788627;4155.189738001091;4163.812628431728;4183.393407955859;3706.09200745819;3708.2398108387983;3711.5731690855628;3711.6473934976134;3719.8326075326404;5166.689998600096;5167.6641018333685;5169.302144210521;5172.9741351293005;5176.922346164811;4855.562999330042;4874.878128046827;4877.707337559757;4879.219324908033;4883.19427294496;5686.971565142189;5693.402192769782;5693.430656934315;5695.544356451515;5701.14482827575;3999.040470169625;4108.609682080198;4112.074783173792;4112.506499220083;4115.300398932159;5900.64596124234;5961.493273071794;5966.850828729273;5969.253843269591;5972.970135149297;4188.308929026676;4209.410682504452;4209.894752631209;4210.5157906841105;4215.936760948588;4277.465316835395;4278.7004909656025;4278.828846846091;4281.079567892918;4281.507626622978;4840.346553215341;4840.540148685869;4842.539958703917;4842.685225460334;4850.1997170466475;5634;5685.431456854281;5699.401562835926;5703.116017017369;5703.17303990919;1399.0626280392162;1480.9259537023106;1504.2553935801848;1505.668752874366;1511.7656763201721;911.5806728904646;966.7728083900278;983.3657291047234;996.8953259907751;1039.4387031003325;4906.141425250638;4922.0648076866;4940.827071052568;4945.55490005894;4949.010197960422;5778.624389414675;5815.302163740378;5819.621724587888;5854.151148083504;5894.469497745138;4944.802207911715;4954.950450495521;4960.429550601655;4961.727105009187;4974.204127339608;3110.860011299497;3139;3152.952705709416;3155.9053228403186;3159.668234835355;5540.7783688652;5548.9722551386985;5555.2778138841695;5559.11054231321;5562.137868630369;5866.208061911588;6112.816615501542;6132.41742034506;6134.2332208473945;6140.600860944024;5589.664620122806;5603.831885043455;5605.887882242414;5607.663540187602;5609.242752228397;5916.526677865674;5918.2898052234;5919.91120133207;5921.555883308855;5923.992921203319;5795.710214489343;5799.2750906136735;5801.767929282782;5806.912896306474;5813.651180929158;5420.268263784339;5595.804146854841;5597.524210441995;5604.271444712162;5610.214569960127;4020.557738648805;4065.6137666921595;4091.468109145792;4098;4102.364133559303;5914.822555323347;5923.674197919156;5926.644401335933;5929.0513517836935;5932.199153114274;5631.915521267102;5675.8864822704145;5678.346990096192;5680.233168522197;5680.630759000652;5710.942890571041;5713.8285851424525;5715.828525144252;5721.599488035798;5724.313082430135;5428.4842939920645;5624.3250809903075;5627.662340259598;5632.183333416713;5632.7746890123935;5735.053716136791;5757.91363129545;5759.798407055733;5763;5764.423557644202;5572.331320241597;5607.214989901336;5630.85922851932;5631.63394379364;5633.0705433603 15:07:19 INFO - PROCESS | 16590 | |5;yui.html;615;628.8270725550476;653.2748648999607;675.8513127112035;740.3669862267761;12517.874821251784;12719.554815581434;12732.172408793422;12732.681682957907;12738.363081845893;12184.939075304612;12654.62036138915;12699.61901142965;12706.872931270684;13703.725925481484;804.9758507244777;833.071125694852;836.1680128272347;837.1753822484848;837.3636036612157;812.8211793405442;821.8849361089452;823.1357075071181;823.6746485138367;823.8064054947083;863.9654413823471;868.1058509734983;868.1708967935606;868.6699054359335;869.2133619074748;849.9575021248913;857.7426771968416;860.1183786618766;860.6084231674573;860.6471346747835;630.5113537008855;631.1195881744986;632.1402892066785;632.1971096707202;633.1357696743958;12809.487620495169;12844.807327890088;12860.099793014493;12876.613701588967;12915.612531624067;12346.382680865921;12593.307368094842;12698.873011269861;12707.301098439582;12866.421011054525;9977.800443991153;10011.249156313306;10160.847587286196;10258.9487052565;10294.7426314342;3289.079057863802;3353.279045005311;3354.547136136639;3370.9831450842835;3431.742619303537;39117.217655647015;42938.355924661155;43742;43875.78062109669;45070.54929450696;9974.202063834875;10035.24735644815;10050.296479246383;10080.09279164864;10264.024917632813;16635;16635.334586616398;16636;16640.417585384697;16684.33262669504;6836.145481814773;6878.071460352789;6956.965215173892;6992.846180380282;7083.6458177090935;3828.655421012122;3893.5788437220776;3899.2786334528205;3899.5905429930017;3918.5689574146822;2817.070366778958;2891.7397434230597;2891.9855400722863;2892.7107289271325;2904.419116176773;508.30362403507434;512.6232219318798;531.0812294730139;533.9305890234244;541.6019225868984;488.93154958305865;574.6063946196869;576.1185386358877;589.9056151015902;607.5777334752305;7690.961545192238;7807.297343239135;7868;7879.645415956295;7989.7203597873795;540.351578106274;556.785637529546;574.7097715653568;583.7460704593516;585.5432762445299;3780.1494663700446;3788.6590206881515;3803.4675145479655;3823.7896915669903;3921.9607803921594;48762;52448.475515245125;52540.47459525432;52680;52823.47176528186;44906.32640510395;45166.09667806626;45480;45651;45886.082278354246;41845.58154418417;41998.37002444966;42390.99999999938;42503.78748106302;42725.145497089885;7822.335101516434;7996.120426753168;8004.557049805675;8094.959525202336;8695.347848911231;31408.685913140576;31848.5222721664;32711.18222044468;33029.17427064342;33077.17307067342;39377.60622393739;39432.6056739429;39872.20255594814;40093.79953100216;40330.59669403268;10127.696169114939;10275.17798576097;10276.17790576737;10281.897181028393;10305.948470257601;10955.123590112613;11039.116870650168;11117.666470005914;11380.94309528447;11472.655820325404;10132.240081993732;10540.683779486628;10631.787364252827;10633.415162166155;10645.361278323326;10790.67627971162;10801.459927003776;10814;11136.498857551267;11395.829062563902;10757.193210509087;10816.621418250637;10937.617183398543;11004;11307.830382544433;8930.732078037669;9143.222826059593;9278.072192780668;9299.09784871633;9484.430934143973;9051.502167380857;9147.451152930846;9298.256139508958;9331.72004839856;9544.618215271312 15:07:19 INFO - PROCESS | 16590 | __end_tp_report 15:07:19 INFO - PROCESS | 16590 | __start_cc_report 15:07:19 INFO - PROCESS | 16590 | _x_x_mozilla_cycle_collect,886 15:07:19 INFO - PROCESS | 16590 | __end_cc_report 15:07:19 INFO - PROCESS | 16590 | __startTimestamp1458252439025__endTimestamp 15:07:19 INFO - PROCESS | 16590 | 15:07:19 INFO - PROCESS | 16590 | ------- Summary: start ------- 15:07:19 INFO - PROCESS | 16590 | Number of tests: 6 15:07:19 INFO - PROCESS | 16590 | 15:07:19 INFO - PROCESS | 16590 | [#0] dojo.html Cycles:165 Average:4668.95 Median:4815.61 stddev:486.04 (10.1%) stddev-sans-first:459.48 15:07:19 INFO - PROCESS | 16590 | Values: 2594.3 2688.4 2697.7 2711.3 2722.8 4593.7 4667.7 4673.2 4703.0 4721.1 4667.6 4700.0 4708.0 4709.4 4716.9 4294.8 4377.8 4412.2 4467.0 4469.8 4182.2 4357.4 4423.0 4433.5 4445.4 4068.3 4282.6 4295.7 4355.1 4380.4 4291.5 4308.5 4311.3 4345.3 4352.8 4143.2 4301.5 4302.4 4308.6 4359.3 4567.7 4626.7 4648.8 4674.3 4691.6 5028.3 5033.1 5042.2 5048.8 5077.5 4994.4 5034.4 5039.4 5049.1 5055.7 4755.3 4770.1 4772.1 4790.8 4818.7 5206.4 5218.8 5224.8 5225.7 5274.1 4797.1 4927.6 4996.9 5007.0 5023.0 5077.6 5082.8 5100.2 5109.6 5122.4 5048.9 5050.4 5051.3 5051.9 5086.1 4820.3 4938.9 5024.4 5043.8 5053.4 4257.8 4262.2 4273.9 4275.5 4321.2 3755.5 3757.2 3764.9 3768.7 3803.2 4290.3 4336.3 4363.6 4400.0 4411.8 5044.1 5066.1 5066.4 5103.5 5135.2 4360.2 4374.5 4375.9 4379.1 4423.6 4394.3 4499.1 4541.5 4559.9 4605.5 4800.2 4804.1 4815.6 4817.5 4871.5 4899.5 5042.6 5049.5 5055.5 5102.3 4707.5 4757.0 4778.4 4821.1 4822.7 4961.4 5003.5 5009.5 5010.4 5046.6 4878.5 4910.6 5078.9 5098.6 5151.6 4912.1 4924.7 4928.6 4928.9 4978.5 4905.3 4928.2 4930.6 4932.3 4974.1 4745.9 4767.5 4843.6 4883.5 4911.9 4925.1 4936.1 4941.5 4969.5 4998.7 4818.9 4824.1 4838.2 4845.0 4891.4 15:07:19 INFO - PROCESS | 16590 | 15:07:19 INFO - PROCESS | 16590 | [#1] ext.html Cycles:180 Average:40486.76 Median:35186.65 stddev:65029.55 (184.8%) stddev-sans-first:65142.76 15:07:19 INFO - PROCESS | 16590 | Values: 527.3 532.5 556.9 557.7 596.9 27431.3 27939.0 34723.1 35021.5 35136.8 38709.0 39034.6 39076.8 39128.4 39218.2 7667.1 7853.2 7855.0 7856.5 7858.9 7700.4 7780.2 7788.3 7833.2 7840.1 7783.7 7858.9 8017.5 8035.5 8038.2 7929.2 8001.0 8001.8 8010.1 8010.8 7888.7 8014.3 8019.9 8021.1 8024.6 39197.6 39607.0 39720.8 39736.6 39749.0 2875.8 3152.0 3281.2 3690.5 3773.8 29828.7 29875.0 29909.1 30018.0 30512.7 3249.3 3258.6 3288.3 3289.6 3321.3 232316.0 233072.0 233362.0 233668.5 234438.0 43745.9 44446.3 44451.3 56614.7 56868.7 42266.2 42289.0 42456.0 42500.8 42529.8 13682.2 13730.9 13812.4 13829.1 13837.8 10776.4 10844.3 10859.5 10866.8 10868.0 14933.9 14942.4 15071.5 15119.9 15229.0 5841.9 6009.0 6057.6 6066.3 6124.4 748.0 838.8 870.8 907.7 1065.8 27018.9 27756.9 28304.7 28578.1 28581.0 979.5 1006.9 1120.6 1136.0 1142.8 14235.0 14666.3 14765.2 14972.3 15041.9 300775.0 303378.0 305017.0 305747.0 306994.0 47682.0 48316.8 48338.3 48398.0 48439.8 1061.4 1219.9 1237.9 1242.1 1359.2 25080.5 27079.0 27732.2 28164.9 28171.2 36407.5 36785.8 37301.1 37419.3 37470.4 176972.1 178827.1 180786.0 186630.0 254898.0 34041.3 34313.8 34803.7 35000.6 35330.5 40071.4 40503.8 44565.1 46217.0 46338.5 34075.3 34593.5 35275.1 35351.6 35792.3 35112.5 35236.5 35536.5 35569.3 35760.0 34826.5 35597.6 35769.0 35968.6 36040.8 30912.0 31282.7 31746.8 31785.5 31809.0 24348.3 24830.5 24998.9 25380.2 25422.1 15:07:19 INFO - PROCESS | 16590 | 15:07:19 INFO - PROCESS | 16590 | [#2] jquery.html Cycles:180 Average:24282.09 Median:25396.59 stddev:71145.29 (280.1%) stddev-sans-first:71322.19 15:07:19 INFO - PROCESS | 16590 | Values: 355.5 359.9 361.7 370.9 372.5 15445.0 15766.4 16223.4 16426.2 16604.3 15703.0 15884.3 17222.2 17229.0 17240.1 4830.6 4897.6 5048.7 5060.5 5061.5 5018.4 5029.3 5053.4 5058.6 5063.8 4948.4 5011.6 5034.9 5037.4 5048.3 5209.3 5210.3 5246.4 5278.5 5283.3 5010.7 5047.5 5049.0 5067.9 5079.2 11696.5 11808.2 11981.7 12004.9 12019.0 1860.9 1925.8 2162.4 2173.0 2236.4 8995.0 9060.3 9089.1 9208.1 9350.2 1792.9 1815.5 1843.5 1844.5 1855.1 41427.4 53509.2 54928.5 60381.7 62341.0 9286.1 10275.5 10324.4 10443.0 10608.2 11982.3 12150.1 12155.6 12174.6 12311.5 5685.0 5770.8 6751.8 7322.4 7341.8 7149.6 7167.7 7238.0 7261.9 7291.6 4302.3 4417.5 4502.8 4541.1 4557.2 1754.6 1795.1 1818.7 1873.9 1876.8 767.8 812.9 853.7 865.8 948.7 15464.4 15967.7 16211.9 16413.8 16516.8 848.5 865.2 868.8 887.9 898.6 9109.7 9261.5 9408.2 9467.5 9557.6 428934.0 430990.0 432511.0 437876.0 438805.0 71765.6 74594.0 77432.6 77436.6 77639.6 962.2 971.1 986.1 996.7 997.4 14811.8 15005.5 15074.0 15227.2 15457.5 24861.0 25999.5 34050.3 34405.6 34933.7 41530.6 44355.6 45587.0 45667.3 45962.5 7428.6 7466.1 7517.8 7750.0 7764.0 9097.5 11710.3 11843.8 11858.1 11880.6 10361.4 10466.3 10490.5 10659.7 10673.9 5318.0 7808.8 9570.3 9698.5 10283.3 9930.9 10115.9 10256.5 10263.9 10505.4 7400.7 7437.4 7437.8 7563.5 7568.4 9072.2 9926.6 9928.4 10052.7 10152.6 15:07:19 INFO - PROCESS | 16590 | 15:07:19 INFO - PROCESS | 16590 | [#3] mootools.html Cycles:180 Average:5341.83 Median:6342.18 stddev:2790.28 (44.0%) stddev-sans-first:2780.92 15:07:19 INFO - PROCESS | 16590 | Values: 1222.6 1412.6 1428.6 1551.6 1752.0 7224.6 7399.4 7404.7 7413.6 7442.3 7279.3 7495.7 7503.6 7512.0 7515.8 1921.9 1979.0 2193.5 2269.9 2291.8 2279.5 2301.6 2301.9 2302.4 2308.4 2221.7 2244.1 2261.3 2274.3 2283.3 2194.7 2243.7 2244.6 2248.8 2270.6 2282.7 2302.0 2304.9 2306.7 2308.6 7402.0 7483.8 7493.9 7498.8 7506.2 4673.3 4798.5 4802.4 4807.1 4809.7 3037.4 3082.7 3153.9 3159.3 3171.7 992.6 997.1 999.3 1017.8 1035.0 10603.7 10606.4 10612.3 10612.6 10625.3 4276.5 4345.3 4403.7 4425.0 4442.5 9013.0 9036.9 9056.5 9068.3 9076.6 4747.0 4766.5 4773.3 4775.9 4777.3 3638.2 3713.9 3745.2 4164.6 4275.4 3743.3 3783.2 3832.0 3854.9 3870.4 1221.5 1235.1 1243.2 1244.5 1255.7 1182.5 1183.2 1192.2 1204.7 1209.7 6921.8 7019.2 7091.5 7137.9 7159.4 470.5 480.6 484.1 484.5 485.7 5547.8 5572.6 5580.2 5582.4 5605.7 9014.5 9248.9 9479.0 9481.1 9573.3 9336.5 9343.8 9376.2 9403.9 9420.8 7124.2 7254.7 7300.6 7315.4 7315.9 6664.0 6686.2 6704.5 6711.8 6733.0 8155.7 8252.5 8321.5 8336.3 8381.7 8520.1 8626.9 8638.8 8667.7 8668.4 6483.3 6550.8 6616.2 6624.4 6626.2 7379.1 7383.9 7399.2 7401.5 7407.5 6588.1 6698.3 6705.3 6777.9 6858.7 6501.4 6512.4 6562.8 6599.7 6671.9 6674.1 6728.9 6732.2 6780.2 6788.4 6250.0 6324.9 6341.3 6343.0 6345.0 6250.3 6361.5 6363.6 6370.8 6384.3 15:07:19 INFO - PROCESS | 16590 | 15:07:19 INFO - PROCESS | 16590 | [#4] prototype.html Cycles:180 Average:4735.27 Median:5389.51 stddev:1381.61 (25.6%) stddev-sans-first:1345.25 15:07:19 INFO - PROCESS | 16590 | Values: 325.2 325.3 327.2 331.7 334.3 5363.9 5413.9 5417.3 5420.4 5423.5 5354.0 5358.5 5377.7 5387.0 5392.1 3999.3 4087.8 4138.3 4186.6 4194.8 4201.6 4212.7 4214.5 4224.6 4225.2 4188.5 4196.2 4196.6 4197.3 4205.8 4006.1 4082.4 4155.2 4163.8 4183.4 3706.1 3708.2 3711.6 3711.6 3719.8 5166.7 5167.7 5169.3 5173.0 5176.9 4855.6 4874.9 4877.7 4879.2 4883.2 5687.0 5693.4 5693.4 5695.5 5701.1 3999.0 4108.6 4112.1 4112.5 4115.3 5900.6 5961.5 5966.9 5969.3 5973.0 4188.3 4209.4 4209.9 4210.5 4215.9 4277.5 4278.7 4278.8 4281.1 4281.5 4840.3 4840.5 4842.5 4842.7 4850.2 5634.0 5685.4 5699.4 5703.1 5703.2 1399.1 1480.9 1504.3 1505.7 1511.8 911.6 966.8 983.4 996.9 1039.4 4906.1 4922.1 4940.8 4945.6 4949.0 5778.6 5815.3 5819.6 5854.2 5894.5 4944.8 4955.0 4960.4 4961.7 4974.2 3110.9 3139.0 3153.0 3155.9 3159.7 5540.8 5549.0 5555.3 5559.1 5562.1 5866.2 6112.8 6132.4 6134.2 6140.6 5589.7 5603.8 5605.9 5607.7 5609.2 5916.5 5918.3 5919.9 5921.6 5924.0 5795.7 5799.3 5801.8 5806.9 5813.7 5420.3 5595.8 5597.5 5604.3 5610.2 4020.6 4065.6 4091.5 4098.0 4102.4 5914.8 5923.7 5926.6 5929.1 5932.2 5631.9 5675.9 5678.3 5680.2 5680.6 5710.9 5713.8 5715.8 5721.6 5724.3 5428.5 5624.3 5627.7 5632.2 5632.8 5735.1 5757.9 5759.8 5763.0 5764.4 5572.3 5607.2 5630.9 5631.6 5633.1 15:07:19 INFO - PROCESS | 16590 | 15:07:19 INFO - PROCESS | 16590 | [#5] yui.html Cycles:180 Average:12728.22 Median:42194.69 stddev:14290.55 (33.9%) stddev-sans-first:14301.69 15:07:19 INFO - PROCESS | 16590 | Values: 615.0 628.8 653.3 675.9 740.4 12517.9 12719.6 12732.2 12732.7 12738.4 12184.9 12654.6 12699.6 12706.9 13703.7 805.0 833.1 836.2 837.2 837.4 812.8 821.9 823.1 823.7 823.8 864.0 868.1 868.2 868.7 869.2 850.0 857.7 860.1 860.6 860.6 630.5 631.1 632.1 632.2 633.1 12809.5 12844.8 12860.1 12876.6 12915.6 12346.4 12593.3 12698.9 12707.3 12866.4 9977.8 10011.2 10160.8 10258.9 10294.7 3289.1 3353.3 3354.5 3371.0 3431.7 39117.2 42938.4 43742.0 43875.8 45070.5 9974.2 10035.2 10050.3 10080.1 10264.0 16635.0 16635.3 16636.0 16640.4 16684.3 6836.1 6878.1 6957.0 6992.8 7083.6 3828.7 3893.6 3899.3 3899.6 3918.6 2817.1 2891.7 2892.0 2892.7 2904.4 508.3 512.6 531.1 533.9 541.6 488.9 574.6 576.1 589.9 607.6 7691.0 7807.3 7868.0 7879.6 7989.7 540.4 556.8 574.7 583.7 585.5 3780.1 3788.7 3803.5 3823.8 3922.0 48762.0 52448.5 52540.5 52680.0 52823.5 44906.3 45166.1 45480.0 45651.0 45886.1 41845.6 41998.4 42391.0 42503.8 42725.1 7822.3 7996.1 8004.6 8095.0 8695.3 31408.7 31848.5 32711.2 33029.2 33077.2 39377.6 39432.6 39872.2 40093.8 40330.6 10127.7 10275.2 10276.2 10281.9 10305.9 10955.1 11039.1 11117.7 11380.9 11472.7 10132.2 10540.7 10631.8 10633.4 10645.4 10790.7 10801.5 10814.0 11136.5 11395.8 10757.2 10816.6 10937.6 11004.0 11307.8 8930.7 9143.2 9278.1 9299.1 9484.4 9051.5 9147.5 9298.3 9331.7 9544.6 15:07:19 INFO - PROCESS | 16590 | -------- Summary: end -------- 15:07:19 INFO - PROCESS | 16590 | 15:07:19 INFO - TEST-INFO | 16590: exit 0 15:07:19 INFO - TEST-OK | dromaeo_css | took 1116541ms 15:07:19 INFO - TEST-START | kraken 15:07:19 INFO - operating with platform_type : linux_ 15:07:19 INFO - Initialising browser for kraken test... 15:07:19 INFO - TEST-INFO | started process 16767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfX3AEE/profile http://localhost:40644/getInfo.html) 15:07:24 INFO - PROCESS | 16767 | __metrics Screen width/height:1600/1200 15:07:24 INFO - PROCESS | 16767 | colorDepth:24 15:07:24 INFO - PROCESS | 16767 | Browser inner width/height: 1024/697 15:07:24 INFO - PROCESS | 16767 | __metrics 15:07:25 ERROR - PROCESS | 16767 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:07:25 INFO - TEST-INFO | 16767: exit 0 15:07:25 INFO - Browser initialized. 15:07:25 INFO - Running cycle 1/1 for kraken test... 15:07:25 INFO - TEST-INFO | started process 16850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfX3AEE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:07:37 INFO - PROCESS | 16850 | RSS: Main: 154451968 15:07:37 INFO - PROCESS | 16850 | 15:07:40 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40644/tests/kraken/driver.html?testName=audio-beat-detection) 15:07:41 INFO - PROCESS | 16850 | RSS: Main: 197500928 15:07:41 INFO - PROCESS | 16850 | 15:07:43 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40644/tests/kraken/driver.html?testName=audio-dft) 15:07:44 INFO - PROCESS | 16850 | RSS: Main: 187682816 15:07:44 INFO - PROCESS | 16850 | 15:07:47 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40644/tests/kraken/driver.html?testName=audio-fft) 15:07:47 INFO - PROCESS | 16850 | RSS: Main: 174145536 15:07:47 INFO - PROCESS | 16850 | 15:07:50 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40644/tests/kraken/driver.html?testName=audio-oscillator) 15:07:50 INFO - PROCESS | 16850 | RSS: Main: 175665152 15:07:50 INFO - PROCESS | 16850 | 15:07:52 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40644/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:07:53 INFO - PROCESS | 16850 | RSS: Main: 175501312 15:07:53 INFO - PROCESS | 16850 | 15:07:56 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40644/tests/kraken/driver.html?testName=imaging-darkroom) 15:07:57 INFO - PROCESS | 16850 | RSS: Main: 175087616 15:07:57 INFO - PROCESS | 16850 | 15:08:00 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40644/tests/kraken/driver.html?testName=imaging-desaturate) 15:08:01 INFO - PROCESS | 16850 | RSS: Main: 178171904 15:08:01 INFO - PROCESS | 16850 | 15:08:04 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40644/tests/kraken/driver.html?testName=json-parse-financial) 15:08:04 INFO - PROCESS | 16850 | RSS: Main: 176660480 15:08:04 INFO - PROCESS | 16850 | 15:08:06 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40644/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:08:06 INFO - PROCESS | 16850 | RSS: Main: 187142144 15:08:06 INFO - PROCESS | 16850 | 15:08:08 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40644/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:08:09 INFO - PROCESS | 16850 | RSS: Main: 183644160 15:08:09 INFO - PROCESS | 16850 | 15:08:11 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40644/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:08:12 INFO - PROCESS | 16850 | RSS: Main: 193998848 15:08:12 INFO - PROCESS | 16850 | 15:08:14 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:08:15 INFO - PROCESS | 16850 | RSS: Main: 199401472 15:08:15 INFO - PROCESS | 16850 | 15:08:17 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:08:18 INFO - PROCESS | 16850 | RSS: Main: 198017024 15:08:18 INFO - PROCESS | 16850 | 15:08:19 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:40644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40644/tests/kraken/driver.html?testName=ai-astar) 15:08:20 INFO - PROCESS | 16850 | RSS: Main: 260014080 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | __start_tp_report 15:08:20 INFO - PROCESS | 16850 | _x_x_mozilla_page_load 15:08:20 INFO - PROCESS | 16850 | _x_x_mozilla_page_load_details 15:08:20 INFO - PROCESS | 16850 | |i|pagename|runs| 15:08:20 INFO - PROCESS | 16850 | |0;ai-astar;113;115;107;112;114;113;103;112;112;115 15:08:20 INFO - PROCESS | 16850 | |1;audio-beat-detection;158;137;158;171;131;168;151;134;170;132 15:08:20 INFO - PROCESS | 16850 | |2;audio-dft;161;160;159;161;160;161;162;162;163;161 15:08:20 INFO - PROCESS | 16850 | |3;audio-fft;73;75;73;155;76;73;73;73;150;76 15:08:20 INFO - PROCESS | 16850 | |4;audio-oscillator;93;93;139;92;94;93;140;93;94;140 15:08:20 INFO - PROCESS | 16850 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 15:08:20 INFO - PROCESS | 16850 | |6;imaging-darkroom;147;147;147;148;147;146;147;147;146;146 15:08:20 INFO - PROCESS | 16850 | |7;imaging-desaturate;96;96;96;97;96;97;96;96;96;96 15:08:20 INFO - PROCESS | 16850 | |8;json-parse-financial;63;63;62;62;62;63;63;72;62;61 15:08:20 INFO - PROCESS | 16850 | |9;json-stringify-tinderbox;63;63;65;65;65;65;68;64;64;65 15:08:20 INFO - PROCESS | 16850 | |10;stanford-crypto-aes;81;82;83;82;81;83;82;81;83;81 15:08:20 INFO - PROCESS | 16850 | |11;stanford-crypto-ccm;118;120;114;117;121;119;124;123;116;114 15:08:20 INFO - PROCESS | 16850 | |12;stanford-crypto-pbkdf2;142;129;142;140;140;129;142;139;140;140 15:08:20 INFO - PROCESS | 16850 | |13;stanford-crypto-sha256-iterative;68;69;67;67;66;66;66;67;66;66 15:08:20 INFO - PROCESS | 16850 | __end_tp_report 15:08:20 INFO - PROCESS | 16850 | __start_cc_report 15:08:20 INFO - PROCESS | 16850 | _x_x_mozilla_cycle_collect,1108 15:08:20 INFO - PROCESS | 16850 | __end_cc_report 15:08:20 INFO - PROCESS | 16850 | __startTimestamp1458252500247__endTimestamp 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | ------- Summary: start ------- 15:08:20 INFO - PROCESS | 16850 | Number of tests: 14 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.78 (3.3%) stddev-sans-first:3.97 15:08:20 INFO - PROCESS | 16850 | Values: 113.0 115.0 107.0 112.0 114.0 113.0 103.0 112.0 112.0 115.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:158.00 stddev:16.31 (10.3%) stddev-sans-first:17.10 15:08:20 INFO - PROCESS | 16850 | Values: 158.0 137.0 158.0 171.0 131.0 168.0 151.0 134.0 170.0 132.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 15:08:20 INFO - PROCESS | 16850 | Values: 161.0 160.0 159.0 161.0 160.0 161.0 162.0 162.0 163.0 161.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#3] audio-fft Cycles:10 Average:89.70 Median:73.00 stddev:33.14 (45.4%) stddev-sans-first:34.60 15:08:20 INFO - PROCESS | 16850 | Values: 73.0 75.0 73.0 155.0 76.0 73.0 73.0 73.0 150.0 76.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:93.00 stddev:22.48 (24.2%) stddev-sans-first:23.26 15:08:20 INFO - PROCESS | 16850 | Values: 93.0 93.0 139.0 92.0 94.0 93.0 140.0 93.0 94.0 140.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:08:20 INFO - PROCESS | 16850 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 15:08:20 INFO - PROCESS | 16850 | Values: 147.0 147.0 147.0 148.0 147.0 146.0 147.0 147.0 146.0 146.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:08:20 INFO - PROCESS | 16850 | Values: 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.00 stddev:3.13 (5.0%) stddev-sans-first:3.32 15:08:20 INFO - PROCESS | 16850 | Values: 63.0 63.0 62.0 62.0 62.0 63.0 63.0 72.0 62.0 61.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.36 15:08:20 INFO - PROCESS | 16850 | Values: 63.0 63.0 65.0 65.0 65.0 65.0 68.0 64.0 64.0 65.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.88 (1.1%) stddev-sans-first:0.87 15:08:20 INFO - PROCESS | 16850 | Values: 81.0 82.0 83.0 82.0 81.0 83.0 82.0 81.0 83.0 81.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:119.50 stddev:3.47 (2.9%) stddev-sans-first:3.67 15:08:20 INFO - PROCESS | 16850 | Values: 118.0 120.0 114.0 117.0 121.0 119.0 124.0 123.0 116.0 114.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.30 Median:140.00 stddev:5.01 (3.6%) stddev-sans-first:5.13 15:08:20 INFO - PROCESS | 16850 | Values: 142.0 129.0 142.0 140.0 140.0 129.0 142.0 139.0 140.0 140.0 15:08:20 INFO - PROCESS | 16850 | 15:08:20 INFO - PROCESS | 16850 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.00 15:08:20 INFO - PROCESS | 16850 | Values: 68.0 69.0 67.0 67.0 66.0 66.0 66.0 67.0 66.0 66.0 15:08:20 INFO - PROCESS | 16850 | -------- Summary: end -------- 15:08:20 INFO - PROCESS | 16850 | 15:08:21 INFO - TEST-INFO | 16850: exit 0 15:08:21 INFO - TEST-OK | kraken | took 61486ms 15:08:21 INFO - SUITE-END | took 1178s 15:08:21 INFO - Completed test suite (00:19:38) 15:08:21 INFO - javascript benchmark 15:08:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2594.26063571882, 2688.3816722153906, 2697.716739742328, 2711.2815103997445, 2722.8366298022115, 4593.701409408394, 4667.743274119922, 4673.158831410345, 4702.9529704702945, 4721.10299043182, 4667.649926255536, 4700.012997270577, 4707.952920470802, 4709.364235828162, 4716.905661886769, 4294.788184085183, 4377.846775362863, 4412.249917514015, 4466.955330446686, 4469.7541635210055, 4182.184474027566, 4357.38996540483, 4423.0, 4433.467983841943, 4445.355423463596, 4068.2677118118727, 4282.635975942048, 4295.656347492209, 4355.085432059272, 4380.408644832971, 4291.527931927485, 4308.46144231971, 4311.267084595626, 4345.304751239786, 4352.8476503322545, 4143.1713657268665, 4301.526832048472, 4302.397664326997, 4308.633766129883, 4359.280718681413, 4567.680262381635, 4626.653001024936, 4648.814047438098, 4674.298855171717, 4691.577758001762, 5028.321176641143, 5033.119204139261, 5042.243663450475, 5048.7728052237735, 5077.466865979056, 4994.350734404504, 5034.395872495287, 5039.395272567279, 5049.065922804256, 5055.696658200483, 4755.286706993978, 4770.069836381942, 4772.117158325721, 4790.784414701347, 4818.68678535894, 5206.427292997767, 5218.7912483500995, 5224.791008359623, 5225.6603320784025, 5274.077036518671, 4797.088553174885, 4927.605791536668, 4996.900061998813, 5006.974965125151, 5022.974885125551, 5077.593792496591, 5082.771275292621, 5100.2349647553165, 5109.565686916654, 5122.385313762373, 5048.949510504848, 5050.419201791768, 5051.292819005343, 5051.924221136685, 5086.109930762102, 4820.3492528508905, 4938.925916111261, 5024.422191447957, 5043.773030213649, 5053.36832895888, 4257.829686812554, 4262.211490874198, 4273.87178384649, 4275.508316543575, 4321.222180007566, 3755.511783468132, 3757.192203676168, 3764.9058773530332, 3768.660820526111, 3803.201327721154, 4290.313549832012, 4336.306191009423, 4363.585459381354, 4400.0, 4411.801468933906, 5044.117279476077, 5066.08810414129, 5066.442691303953, 5103.489651034867, 5135.178371460548, 4360.236958532244, 4374.540673229265, 4375.912481750347, 4379.1022840317655, 4423.623991960655, 4394.252976993918, 4499.055198408306, 4541.455025396907, 4559.886002849889, 4605.4933957264675, 4800.231962885921, 4804.135255653946, 4815.6147508199965, 4817.518248175154, 4871.464138944642, 4899.510048995072, 5042.621803364836, 5049.495050494921, 5055.51972562606, 5102.285680004877, 4707.529247075402, 4756.9762151189025, 4778.354922085474, 4821.083994041121, 4822.662413631012, 4961.404631444249, 5003.499650034967, 5009.5491405773655, 5010.448850626501, 5046.646734728533, 4878.463369029475, 4910.607151427806, 5078.949210507848, 5098.617603679813, 5151.587872970228, 4912.091263116335, 4924.655274130777, 4928.630352723489, 4928.852134435972, 4978.47725988766, 4905.313256144072, 4928.186849169847, 4930.556249937379, 4932.284818701197, 4974.0797952378925, 4745.932165262789, 4767.451743049455, 4843.6367272454, 4883.487233840396, 4911.877203069952, 4925.113479573711, 4936.111499929903, 4941.456439791692, 4969.503049695001, 4998.6750861193905, 4818.903621927471, 4824.059308434821, 4838.2016967201425, 4844.95155048445, 4891.388576427947], "unit": "score", "name": "dojo.html", "value": 4638.572115918901}, {"lowerIsBetter": false, "replicates": [527.2934268080771, 532.5499952540104, 556.8663520755017, 557.7350758389765, 596.9134475501049, 27431.314217144558, 27939.0, 34723.13192170197, 35021.474677879785, 35136.82431587839, 38709.0, 39034.609653903455, 39076.80461597688, 39128.41307380392, 39218.215635687266, 7667.079950405945, 7853.175416581234, 7855.0, 7856.450048496607, 7858.8821167682245, 7700.383969282444, 7780.221977802203, 7788.260115289038, 7833.177516360785, 7840.059192896861, 7783.688652453923, 7858.921410785904, 8017.478863873858, 8035.477693949903, 8038.155993620673, 7929.207079292053, 8001.0, 8001.759947201594, 8010.078840933309, 8010.759677209693, 7888.684452621888, 8014.2787149156275, 8019.879701804478, 8021.117677055519, 8024.598770061473, 39197.608023919965, 39607.0, 39720.80139599313, 39736.60263397387, 39749.0, 2875.7699384049224, 3152.021339833858, 3281.212508997847, 3690.464882592036, 3773.754705944105, 29828.70171298281, 29875.0, 29909.102726918227, 30018.0, 30512.69487305121, 3249.333886553251, 3258.560094387251, 3288.2765791525826, 3289.6381398046196, 3321.2693207494312, 232316.0, 233072.0, 233362.0, 233668.47486438585, 234438.0, 43745.906352341444, 44446.33330500045, 44451.333230001575, 56614.7169264151, 56868.71565642145, 42266.15467690629, 42289.0, 42456.0, 42500.78749606294, 42529.787351063045, 13682.247476388695, 13730.862691372959, 13812.37844297009, 13829.10110842792, 13837.792433113511, 10776.407297598707, 10844.349339039683, 10859.457027148612, 10866.836997445045, 10868.0, 14933.925330373278, 14942.402303907722, 15071.54785356441, 15119.924400377928, 15229.0, 5841.9415805842245, 6009.0, 6057.637031667839, 6066.332703402622, 6124.418180272867, 747.9738209162654, 838.8238469921263, 870.8171284030425, 907.6598118922429, 1065.8028264771042, 27018.864905675346, 27756.861215693792, 28304.71695283062, 28578.142655720363, 28581.0, 979.4857699707568, 1006.8942761010135, 1120.5517792882913, 1135.9886401136048, 1142.8400023996646, 14235.0, 14666.266686665624, 14765.187914664582, 14972.326245318987, 15041.924790375979, 300775.0, 303378.0, 305017.0, 305747.0, 306994.0, 47682.0, 48316.758416208395, 48338.274925875434, 48398.0, 48439.757801211475, 1061.3790932304535, 1219.878012198773, 1237.9442925068574, 1242.0746543824907, 1359.16411406984, 25080.498390032462, 27079.0, 27732.168034958984, 28164.85917570399, 28171.154865354074, 36407.45388819117, 36785.81607092055, 37301.0674733123, 37419.251614967005, 37470.43794343142, 176972.1151394235, 178827.10586446984, 180786.0, 186630.0, 254898.0, 34041.31917361589, 34313.828430857684, 34803.651963481054, 35000.64999349974, 35330.47004294989, 40071.39892901551, 40503.79748101241, 44565.10869782651, 46217.0, 46338.53661463342, 34075.31849362949, 34593.48109778305, 35275.118122047155, 35351.646483535864, 35792.28415431729, 35112.47331289982, 35236.47145292874, 35536.46695299624, 35569.28861422809, 35760.0, 34826.47760283649, 35597.644023559435, 35769.0, 35968.64031359653, 36040.8197959019, 30912.0, 31282.68717312889, 31746.841265793522, 31785.523217151298, 31809.0, 24348.269551913472, 24830.50338993174, 24998.87509561635, 25380.238592842245, 25422.110226141995], "unit": "score", "name": "ext.html", "value": 16828.083197319327}, {"lowerIsBetter": false, "replicates": [355.46325049175744, 359.9082234030322, 361.6835269139503, 370.85721997031135, 372.4878292348021, 15445.0, 15766.369345226192, 16223.351065957348, 16426.17869106546, 16604.335826566952, 15703.0, 15884.285207165676, 17222.224999875005, 17229.0, 17240.137993100358, 4830.637702172334, 4897.583705385037, 5048.697078175322, 5060.54455099041, 5061.493850614946, 5018.422881368653, 5029.2958985742025, 5053.36832895888, 5058.620603454738, 5063.797448102072, 4948.38145231846, 5011.624128190382, 5034.899302013958, 5037.395512538482, 5048.29323894655, 5209.348831396075, 5210.270562121306, 5246.422893481714, 5278.498542638443, 5283.260343551887, 5010.72441015744, 5047.545720885101, 5048.990201959586, 5067.949320506785, 5079.161938280179, 11696.47365868538, 11808.173427860052, 11981.700457488545, 12004.939975300154, 12019.0, 1860.8927688025603, 1925.7785354684252, 2162.362103179566, 2172.9891350543303, 2236.4073520517077, 8995.0, 9060.275177985744, 9089.136532029446, 9208.12522810332, 9350.205232555241, 1792.937247196355, 1815.5279627296866, 1843.502254391307, 1844.4927644897625, 1855.0631930874956, 41427.378589320884, 53509.1973620396, 54928.450715492734, 60381.6980915097, 62340.99999999955, 9286.096350248317, 10275.537600807982, 10324.432156231329, 10443.0, 10608.204384671026, 11982.34097124649, 12150.088743344108, 12155.635330940086, 12174.57388991381, 12311.50753969849, 5684.971575142098, 5770.798022069292, 6751.831204219836, 7322.4276603019825, 7341.816454588571, 7149.571025738473, 7167.677454514559, 7237.963810180915, 7261.89107163393, 7291.598962057032, 4302.290122129876, 4417.491988421309, 4502.797374118107, 4541.114482675913, 4557.225271703818, 1754.561359660085, 1795.1383335998532, 1818.6544556534216, 1873.9156737946826, 1876.8310852023383, 767.8042099264763, 812.9309008734324, 853.6500034985626, 865.8008658008694, 948.7485816258697, 15464.381424742884, 15967.69276135943, 16211.918940405223, 16413.753793693104, 16516.75224871628, 848.4612271207827, 865.182402629509, 868.847951608466, 887.924526415249, 898.6270697660528, 9109.68116115946, 9261.536923153815, 9408.247340212767, 9467.479288639053, 9557.569909354095, 428934.0, 430990.0, 432511.0, 437876.0, 438805.0, 71765.64117179485, 74594.0, 77432.61283693546, 77436.61281693555, 77639.61180194063, 962.1821451765943, 971.0629242780609, 986.068165583531, 996.7159359582339, 997.3816233935007, 14811.777823332874, 15005.549833505012, 15074.0, 15227.162506062274, 15457.5362739118, 24861.0, 25999.480010400064, 34050.31899362049, 34405.59160858716, 34933.65066349304, 41530.58469415267, 44355.55644443514, 45587.0, 45667.31499027584, 45962.54037459716, 7428.554286742813, 7466.104067511933, 7517.812054698677, 7749.961250193713, 7764.0, 9097.454152750855, 11710.297382157098, 11843.822342665038, 11858.11064170208, 11880.643580692593, 10361.430121343097, 10466.319689220481, 10490.52792624349, 10659.733506662396, 10673.8932610676, 5318.0, 7808.828675698691, 9570.282228832726, 9698.466584337646, 10283.280170388001, 9930.851037234303, 10115.949420252851, 10256.538455769658, 10263.948680256552, 10505.369677819355, 7400.718439279828, 7437.405007599271, 7437.772767493303, 7563.470557060953, 7568.394528437601, 9072.183503484453, 9926.553305101432, 9928.404295742279, 10052.748681283027, 10152.593896244067], "unit": "score", "name": "jquery.html", "value": 7835.237468046598}, {"lowerIsBetter": false, "replicates": [1222.5720997650817, 1412.611531828747, 1428.621415324939, 1551.612096975756, 1752.0188694331168, 7224.602646854428, 7399.371053460449, 7404.703811847533, 7413.555186688803, 7442.292982166692, 7279.272072792718, 7495.700171993128, 7503.624818759054, 7512.023436953202, 7515.812104697386, 1921.9423417297503, 1978.9703154452695, 2193.484531135182, 2269.8524595901254, 2291.8166546676225, 2279.4985103277254, 2301.551197516485, 2301.861888286708, 2302.3898666853297, 2308.3882771065682, 2221.688963545097, 2244.057495851738, 2261.298997310839, 2274.283600665793, 2283.337832028718, 2194.7394183990514, 2243.7083179186684, 2244.62963611004, 2248.820094392445, 2270.5572413379396, 2282.703248577691, 2302.033146078651, 2304.896279667419, 2306.6540018997116, 2308.6306191009357, 7402.0, 7483.775486735407, 7493.887591686129, 7498.775036748852, 7506.17432082476, 4673.252279635242, 4798.520147985174, 4802.35168252285, 4807.134715751164, 4809.663323567352, 3037.3621539476735, 3082.660907300195, 3153.8896138635037, 3159.273367125551, 3171.7304029157317, 992.5979978108877, 997.0677416615488, 999.3354419311149, 1017.7685847434366, 1034.953427095775, 10603.734906627318, 10606.416647084407, 10612.257142000062, 10612.62855800051, 10625.309354891984, 4276.48682158143, 4345.304751239786, 4403.713758605681, 4425.048614547888, 4442.4669039715445, 9013.0, 9036.8644470333, 9056.50189239585, 9068.274538036942, 9076.636934522545, 4746.976265118652, 4766.547178018082, 4773.260144677581, 4775.928361074587, 4777.259524773665, 3638.199596088856, 3713.925721485555, 3745.1573395985683, 4164.562720914321, 4275.358696195595, 3743.3074881147077, 3783.1677031053123, 3831.980840095782, 3854.865079722252, 3870.4194370844034, 1221.4930803716359, 1235.0736947289533, 1243.1795015289865, 1244.508419174439, 1255.7488502299577, 1182.5092586576645, 1183.1599564309436, 1192.1952681939656, 1204.747003129335, 1209.679434949739, 6921.792346229621, 7019.227884932653, 7091.468139889529, 7137.89293160603, 7159.355657990805, 470.4613217865525, 480.6323162780476, 484.1189035954529, 484.5396872970692, 485.74741134609803, 5547.833564993057, 5572.637778544382, 5580.218769372291, 5582.358028826656, 5605.691686957257, 9014.459132452073, 9248.861267081, 9479.0, 9481.146696797321, 9573.28200384974, 9336.533173341442, 9343.813123737624, 9376.203022743006, 9403.905960940303, 9420.811583768424, 7124.180719217253, 7254.673539690727, 7300.598467084255, 7315.4147668186415, 7315.8536829264185, 6664.0, 6686.1642294713165, 6704.463642908653, 6711.798646040626, 6733.0, 8155.673773049011, 8252.546109964009, 8321.500709957421, 8336.29141522953, 8381.706640267561, 8520.10538893432, 8626.870596940926, 8638.78403039904, 8667.696630617898, 8668.436551624125, 6483.254425740912, 6550.83622909412, 6616.239132499824, 6624.436922861611, 6626.171728533934, 7379.077615298088, 7383.852322953403, 7399.18608953004, 7401.48189626721, 7407.481476296823, 6588.110605068446, 6698.296678848651, 6705.262421133769, 6777.93222067773, 6858.725650973905, 6501.44737697301, 6512.381323774234, 6562.8359291018105, 6599.67001649906, 6671.8999215010845, 6674.098996635392, 6728.932710673026, 6732.192136943598, 6780.186377634715, 6788.422984046214, 6250.0, 6324.873502530016, 6341.302456729848, 6343.0485427186295, 6345.0, 6250.312465628868, 6361.459275961595, 6363.649999250086, 6370.8088757337355, 6384.297727249906], "unit": "score", "name": "mootools.html", "value": 4323.636691619507}, {"lowerIsBetter": false, "replicates": [325.16108440224207, 325.3217042466457, 327.17714946908546, 331.7163824929685, 334.26295019482046, 5363.919541206885, 5413.918791218125, 5417.34991800984, 5420.403755586883, 5423.511883930445, 5354.0, 5358.490943360384, 5377.677339359631, 5386.973065134669, 5392.056390131721, 3999.300122478569, 4087.7547347159116, 4138.317177665682, 4186.56041115683, 4194.832206711728, 4201.6218540331365, 4212.662986961036, 4214.473190851144, 4224.640905523019, 4225.197212529625, 4188.476440444944, 4196.181744559812, 4196.601322874322, 4197.307444271692, 4205.768682722449, 4006.078601921545, 4082.3672330788627, 4155.189738001091, 4163.812628431728, 4183.393407955859, 3706.09200745819, 3708.2398108387983, 3711.5731690855628, 3711.6473934976134, 3719.8326075326404, 5166.689998600096, 5167.6641018333685, 5169.302144210521, 5172.9741351293005, 5176.922346164811, 4855.562999330042, 4874.878128046827, 4877.707337559757, 4879.219324908033, 4883.19427294496, 5686.971565142189, 5693.402192769782, 5693.430656934315, 5695.544356451515, 5701.14482827575, 3999.040470169625, 4108.609682080198, 4112.074783173792, 4112.506499220083, 4115.300398932159, 5900.64596124234, 5961.493273071794, 5966.850828729273, 5969.253843269591, 5972.970135149297, 4188.308929026676, 4209.410682504452, 4209.894752631209, 4210.5157906841105, 4215.936760948588, 4277.465316835395, 4278.7004909656025, 4278.828846846091, 4281.079567892918, 4281.507626622978, 4840.346553215341, 4840.540148685869, 4842.539958703917, 4842.685225460334, 4850.1997170466475, 5634.0, 5685.431456854281, 5699.401562835926, 5703.116017017369, 5703.17303990919, 1399.0626280392162, 1480.9259537023106, 1504.2553935801848, 1505.668752874366, 1511.7656763201721, 911.5806728904646, 966.7728083900278, 983.3657291047234, 996.8953259907751, 1039.4387031003325, 4906.141425250638, 4922.0648076866, 4940.827071052568, 4945.55490005894, 4949.010197960422, 5778.624389414675, 5815.302163740378, 5819.621724587888, 5854.151148083504, 5894.469497745138, 4944.802207911715, 4954.950450495521, 4960.429550601655, 4961.727105009187, 4974.204127339608, 3110.860011299497, 3139.0, 3152.952705709416, 3155.9053228403186, 3159.668234835355, 5540.7783688652, 5548.9722551386985, 5555.2778138841695, 5559.11054231321, 5562.137868630369, 5866.208061911588, 6112.816615501542, 6132.41742034506, 6134.2332208473945, 6140.600860944024, 5589.664620122806, 5603.831885043455, 5605.887882242414, 5607.663540187602, 5609.242752228397, 5916.526677865674, 5918.2898052234, 5919.91120133207, 5921.555883308855, 5923.992921203319, 5795.710214489343, 5799.2750906136735, 5801.767929282782, 5806.912896306474, 5813.651180929158, 5420.268263784339, 5595.804146854841, 5597.524210441995, 5604.271444712162, 5610.214569960127, 4020.557738648805, 4065.6137666921595, 4091.468109145792, 4098.0, 4102.364133559303, 5914.822555323347, 5923.674197919156, 5926.644401335933, 5929.0513517836935, 5932.199153114274, 5631.915521267102, 5675.8864822704145, 5678.346990096192, 5680.233168522197, 5680.630759000652, 5710.942890571041, 5713.8285851424525, 5715.828525144252, 5721.599488035798, 5724.313082430135, 5428.4842939920645, 5624.3250809903075, 5627.662340259598, 5632.183333416713, 5632.7746890123935, 5735.053716136791, 5757.91363129545, 5759.798407055733, 5763.0, 5764.423557644202, 5572.331320241597, 5607.214989901336, 5630.85922851932, 5631.63394379364, 5633.0705433603], "unit": "score", "name": "prototype.html", "value": 4295.639321398982}, {"lowerIsBetter": false, "replicates": [615.0, 628.8270725550476, 653.2748648999607, 675.8513127112035, 740.3669862267761, 12517.874821251784, 12719.554815581434, 12732.172408793422, 12732.681682957907, 12738.363081845893, 12184.939075304612, 12654.62036138915, 12699.61901142965, 12706.872931270684, 13703.725925481484, 804.9758507244777, 833.071125694852, 836.1680128272347, 837.1753822484848, 837.3636036612157, 812.8211793405442, 821.8849361089452, 823.1357075071181, 823.6746485138367, 823.8064054947083, 863.9654413823471, 868.1058509734983, 868.1708967935606, 868.6699054359335, 869.2133619074748, 849.9575021248913, 857.7426771968416, 860.1183786618766, 860.6084231674573, 860.6471346747835, 630.5113537008855, 631.1195881744986, 632.1402892066785, 632.1971096707202, 633.1357696743958, 12809.487620495169, 12844.807327890088, 12860.099793014493, 12876.613701588967, 12915.612531624067, 12346.382680865921, 12593.307368094842, 12698.873011269861, 12707.301098439582, 12866.421011054525, 9977.800443991153, 10011.249156313306, 10160.847587286196, 10258.9487052565, 10294.7426314342, 3289.079057863802, 3353.279045005311, 3354.547136136639, 3370.9831450842835, 3431.742619303537, 39117.217655647015, 42938.355924661155, 43742.0, 43875.78062109669, 45070.54929450696, 9974.202063834875, 10035.24735644815, 10050.296479246383, 10080.09279164864, 10264.024917632813, 16635.0, 16635.334586616398, 16636.0, 16640.417585384697, 16684.33262669504, 6836.145481814773, 6878.071460352789, 6956.965215173892, 6992.846180380282, 7083.6458177090935, 3828.655421012122, 3893.5788437220776, 3899.2786334528205, 3899.5905429930017, 3918.5689574146822, 2817.070366778958, 2891.7397434230597, 2891.9855400722863, 2892.7107289271325, 2904.419116176773, 508.30362403507434, 512.6232219318798, 531.0812294730139, 533.9305890234244, 541.6019225868984, 488.93154958305865, 574.6063946196869, 576.1185386358877, 589.9056151015902, 607.5777334752305, 7690.961545192238, 7807.297343239135, 7868.0, 7879.645415956295, 7989.7203597873795, 540.351578106274, 556.785637529546, 574.7097715653568, 583.7460704593516, 585.5432762445299, 3780.1494663700446, 3788.6590206881515, 3803.4675145479655, 3823.7896915669903, 3921.9607803921594, 48762.0, 52448.475515245125, 52540.47459525432, 52680.0, 52823.47176528186, 44906.32640510395, 45166.09667806626, 45480.0, 45651.0, 45886.082278354246, 41845.58154418417, 41998.37002444966, 42390.99999999938, 42503.78748106302, 42725.145497089885, 7822.335101516434, 7996.120426753168, 8004.557049805675, 8094.959525202336, 8695.347848911231, 31408.685913140576, 31848.5222721664, 32711.18222044468, 33029.17427064342, 33077.17307067342, 39377.60622393739, 39432.6056739429, 39872.20255594814, 40093.79953100216, 40330.59669403268, 10127.696169114939, 10275.17798576097, 10276.17790576737, 10281.897181028393, 10305.948470257601, 10955.123590112613, 11039.116870650168, 11117.666470005914, 11380.94309528447, 11472.655820325404, 10132.240081993732, 10540.683779486628, 10631.787364252827, 10633.415162166155, 10645.361278323326, 10790.67627971162, 10801.459927003776, 10814.0, 11136.498857551267, 11395.829062563902, 10757.193210509087, 10816.621418250637, 10937.617183398543, 11004.0, 11307.830382544433, 8930.732078037669, 9143.222826059593, 9278.072192780668, 9299.09784871633, 9484.430934143973, 9051.502167380857, 9147.451152930846, 9298.256139508958, 9331.72004839856, 9544.618215271312], "unit": "score", "name": "yui.html", "value": 5939.068046339268}], "name": "dromaeo_css", "value": 6380.449260397751}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 107.0, 112.0, 114.0, 113.0, 103.0, 112.0, 112.0, 115.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [158.0, 137.0, 158.0, 171.0, 131.0, 168.0, 151.0, 134.0, 170.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 161.0, 160.0, 161.0, 162.0, 162.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 73.0, 155.0, 76.0, 73.0, 73.0, 73.0, 150.0, 76.0], "unit": "score", "name": "audio-fft", "value": 89.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 139.0, 92.0, 94.0, 93.0, 140.0, 93.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0, 72.0, 62.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 63.3}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 65.0, 65.0, 65.0, 65.0, 68.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 82.0, 81.0, 83.0, 82.0, 81.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [118.0, 120.0, 114.0, 117.0, 121.0, 119.0, 124.0, 123.0, 116.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [142.0, 129.0, 142.0, 140.0, 140.0, 129.0, 142.0, 139.0, 140.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1514.0}]} 15:08:21 INFO - Return code: 0 15:08:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:08:21 ERROR - # TBPL SUCCESS # 15:08:21 INFO - Running post-action listener: _resource_record_post_action 15:08:21 INFO - Running post-run listener: _resource_record_post_run 15:08:22 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518266880; Read time: 20; Write time: 557144 15:08:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232579072; Read time: 0; Write time: 306404 15:08:22 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285687808; Read time: 20; Write time: 250740 15:08:22 INFO - Running post-run listener: _upload_blobber_files 15:08:22 INFO - Blob upload gear active. 15:08:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:08:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:08:23 INFO - (blobuploader) - INFO - Open directory for files ... 15:08:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:08:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:08:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:23 INFO - (blobuploader) - INFO - Done attempting. 15:08:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:08:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:08:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:24 INFO - (blobuploader) - INFO - Done attempting. 15:08:24 INFO - (blobuploader) - INFO - Iteration through files over. 15:08:24 INFO - Return code: 0 15:08:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:08:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:08:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d4df35d6f72ee40e5b33a682cb979a3719292dba9dffc46a37c2a31a890111ba3f9161696e62c4f4bc2d9d7a3a8348e50430f673a4572c0668e4aded0f327d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0f3bd4c34288126055bae2998cf4ceaf9fae3499b8d4c2e2f4eae9c624d98b1c19fd2bad43fcc2e4222ffe0e2a81d94006bd9bf5130943d32353d67fb8c7ac5"} 15:08:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:08:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:08:24 INFO - Contents: 15:08:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d4df35d6f72ee40e5b33a682cb979a3719292dba9dffc46a37c2a31a890111ba3f9161696e62c4f4bc2d9d7a3a8348e50430f673a4572c0668e4aded0f327d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0f3bd4c34288126055bae2998cf4ceaf9fae3499b8d4c2e2f4eae9c624d98b1c19fd2bad43fcc2e4222ffe0e2a81d94006bd9bf5130943d32353d67fb8c7ac5"} 15:08:24 INFO - Running post-run listener: copy_logs_to_upload_dir 15:08:24 INFO - Copying logs to upload dir... 15:08:24 INFO - mkdir: /builds/slave/test/build/upload/logs 15:08:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.263900 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-03-17 15:08:24.979305) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 15:08:24.986339) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687 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/0d4df35d6f72ee40e5b33a682cb979a3719292dba9dffc46a37c2a31a890111ba3f9161696e62c4f4bc2d9d7a3a8348e50430f673a4572c0668e4aded0f327d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0f3bd4c34288126055bae2998cf4ceaf9fae3499b8d4c2e2f4eae9c624d98b1c19fd2bad43fcc2e4222ffe0e2a81d94006bd9bf5130943d32353d67fb8c7ac5"} build_url:https://queue.taskcluster.net/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/THJ4sGqHRmqYUTmGnVSfSQ/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/0d4df35d6f72ee40e5b33a682cb979a3719292dba9dffc46a37c2a31a890111ba3f9161696e62c4f4bc2d9d7a3a8348e50430f673a4572c0668e4aded0f327d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e0f3bd4c34288126055bae2998cf4ceaf9fae3499b8d4c2e2f4eae9c624d98b1c19fd2bad43fcc2e4222ffe0e2a81d94006bd9bf5130943d32353d67fb8c7ac5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 15:08:25.010573) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 15:08:25.010864) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458251131.851798-1434793687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 15:08:25.095871) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 15:08:25.096206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 15:08:25.096513) ========= ========= Total master_lag: 0.57 =========