builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1459896731.35 results: success (0) buildid: 20160405145306 builduid: 5b0dc1f9e5a54ed8adbe4678efb36fd8 revision: b3eed99cb17bc8d6e6eda1a6f4ecb53fd1b30a43 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.352168) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.352649) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.352951) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006402 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.384195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.384497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.449562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.449855) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.509997) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.510262) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.510606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.510902) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 15:52:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.3M=0s 2016-04-05 15:52:11 (45.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098253 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.625324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.625609) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022453 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.676137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:11.676437) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b3eed99cb17bc8d6e6eda1a6f4ecb53fd1b30a43 --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 b3eed99cb17bc8d6e6eda1a6f4ecb53fd1b30a43 --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=652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 15:52:12,014 truncating revision to first 12 chars 2016-04-05 15:52:12,014 Setting DEBUG logging. 2016-04-05 15:52:12,014 attempt 1/10 2016-04-05 15:52:12,014 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b3eed99cb17b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 15:52:12,296 unpacking tar archive at: fx-team-b3eed99cb17b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566497 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:12.255307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:12.255614) ========= echo b3eed99cb17bc8d6e6eda1a6f4ecb53fd1b30a43 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b3eed99cb17bc8d6e6eda1a6f4ecb53fd1b30a43'] 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=652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b3eed99cb17bc8d6e6eda1a6f4ecb53fd1b30a43 program finished with exit code 0 elapsedTime=0.003875 script_repo_revision: 'b3eed99cb17bc8d6e6eda1a6f4ecb53fd1b30a43' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:12.303900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:12.304188) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 15:52:12.319473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-05 15:52:12.319758) ========= /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=652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:52:12 INFO - MultiFileLogger online at 20160405 15:52:12 in /builds/slave/test 15:52:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:52:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:12 INFO - {'append_to_log': False, 15:52:12 INFO - 'base_work_dir': '/builds/slave/test', 15:52:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:52:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:12 INFO - 'branch': 'Fx-Team-Non-PGO', 15:52:12 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:12 INFO - 'config_files': ('talos/linux_config.py',), 15:52:12 INFO - 'default_actions': ('clobber', 15:52:12 INFO - 'read-buildbot-config', 15:52:12 INFO - 'download-and-extract', 15:52:12 INFO - 'populate-webroot', 15:52:12 INFO - 'create-virtualenv', 15:52:12 INFO - 'install', 15:52:12 INFO - 'run-tests'), 15:52:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:12 INFO - 'download_minidump_stackwalk': True, 15:52:12 INFO - 'download_symbols': 'ondemand', 15:52:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:12 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:12 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:12 INFO - 'installer_path': 'installer.exe', 15:52:12 INFO - 'log_level': 'info', 15:52:12 INFO - 'log_name': 'talos', 15:52:12 INFO - 'log_to_console': True, 15:52:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:52:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:52:12 INFO - 'opt_config_files': (), 15:52:12 INFO - 'pip_index': False, 15:52:12 INFO - 'sps_profile': False, 15:52:12 INFO - 'sps_profile_interval': 0, 15:52:12 INFO - 'suite': 'dromaeojs', 15:52:12 INFO - 'system_bits': '32', 15:52:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:12 INFO - 'title': 'talos-linux64-ix-046', 15:52:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:12 INFO - 'use_talos_json': True, 15:52:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:12 INFO - 'work_dir': 'build'} 15:52:12 INFO - ##### 15:52:12 INFO - ##### Running clobber step. 15:52:12 INFO - ##### 15:52:12 INFO - Running pre-action listener: _resource_record_pre_action 15:52:12 INFO - Running main action method: clobber 15:52:12 INFO - rmtree: /builds/slave/test/build 15:52:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:13 INFO - Running post-action listener: _resource_record_post_action 15:52:13 INFO - ##### 15:52:13 INFO - ##### Running read-buildbot-config step. 15:52:13 INFO - ##### 15:52:13 INFO - Running pre-action listener: _resource_record_pre_action 15:52:13 INFO - Running main action method: read_buildbot_config 15:52:13 INFO - Using buildbot properties: 15:52:13 INFO - { 15:52:13 INFO - "project": "", 15:52:13 INFO - "product": "firefox", 15:52:13 INFO - "script_repo_revision": "production", 15:52:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:52:13 INFO - "repository": "", 15:52:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:52:13 INFO - "buildid": "20160405145306", 15:52:13 INFO - "pgo_build": "False", 15:52:13 INFO - "basedir": "/builds/slave/test", 15:52:13 INFO - "buildnumber": 2761, 15:52:13 INFO - "slavename": "talos-linux64-ix-046", 15:52:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:52:13 INFO - "platform": "ubuntu64_hw", 15:52:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:52:13 INFO - "branch": "fx-team", 15:52:13 INFO - "repo_path": "integration/fx-team", 15:52:13 INFO - "revision": "b3eed99cb17bc8d6e6eda1a6f4ecb53fd1b30a43", 15:52:13 INFO - "stage_platform": "linux64", 15:52:13 INFO - "builduid": "5b0dc1f9e5a54ed8adbe4678efb36fd8", 15:52:13 INFO - "slavebuilddir": "test" 15:52:13 INFO - } 15:52:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:52:13 INFO - Running post-action listener: _resource_record_post_action 15:52:13 INFO - ##### 15:52:13 INFO - ##### Running download-and-extract step. 15:52:13 INFO - ##### 15:52:13 INFO - Running pre-action listener: _resource_record_pre_action 15:52:13 INFO - Running main action method: download_and_extract 15:52:13 INFO - mkdir: /builds/slave/test/build/tests 15:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:13 INFO - https://queue.taskcluster.net/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:52:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:52:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:52:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:52:15 INFO - Downloaded 1361 bytes. 15:52:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:52:15 INFO - Using the following test package requirements: 15:52:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:52:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:52:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:15 INFO - u'jsshell-linux-x86_64.zip'], 15:52:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:52:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:52:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:52:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:52:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:52:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:15 INFO - https://queue.taskcluster.net/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:52:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:52:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:52:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:52:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:52:17 INFO - Downloaded 22125485 bytes. 15:52:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:52:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:52:18 INFO - Return code: 0 15:52:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:18 INFO - https://queue.taskcluster.net/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:52:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:52:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:52:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:52:40 INFO - Downloaded 22125485 bytes. 15:52:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:52:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:52:41 INFO - Return code: 0 15:52: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')]} 15:52:41 INFO - https://queue.taskcluster.net/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:52:42 INFO - Downloaded 10847584 bytes. 15:52:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:52:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:52:42 INFO - Return code: 0 15:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:42 INFO - https://queue.taskcluster.net/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:52:44 INFO - Downloaded 54082240 bytes. 15:52:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:52:44 INFO - mkdir: /builds/slave/test/properties 15:52:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:44 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:44 INFO - Contents: 15:52:44 INFO - build_url:https://queue.taskcluster.net/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:52:45 INFO - Running post-action listener: _resource_record_post_action 15:52:45 INFO - Running post-action listener: set_extra_try_arguments 15:52:45 INFO - ##### 15:52:45 INFO - ##### Running populate-webroot step. 15:52:45 INFO - ##### 15:52:45 INFO - Running pre-action listener: _resource_record_pre_action 15:52:45 INFO - Running main action method: populate_webroot 15:52:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:45 INFO - '--tppagecycles', 15:52:45 INFO - '7'], 15:52:45 INFO - 'tests': ['tsvgm']}}, 15:52:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:52:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:52:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:52:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:52:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:45 INFO - 'talos_options': ['--e10s'], 15:52:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:45 INFO - 'tests': ['damp', 'tps']}, 15:52:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:45 INFO - 'talos_options': ['--e10s'], 15:52:45 INFO - 'tests': ['damp', 'tps']}, 15:52:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:52:45 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 15:52:45 INFO - 'tests': ['dromaeo_dom']}, 15:52:45 INFO - 'other': {'tests': ['a11yr', 15:52:45 INFO - 'ts_paint', 15:52:45 INFO - 'tpaint', 15:52:45 INFO - 'sessionrestore', 15:52:45 INFO - 'sessionrestore_no_auto_restore', 15:52:45 INFO - 'tabpaint']}, 15:52:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:52:45 INFO - 'tests': ['a11yr', 15:52:45 INFO - 'ts_paint', 15:52:45 INFO - 'tpaint', 15:52:45 INFO - 'sessionrestore', 15:52:45 INFO - 'sessionrestore_no_auto_restore', 15:52:45 INFO - 'tabpaint']}, 15:52:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:52:45 INFO - 'tests': ['a11yr', 15:52:45 INFO - 'ts_paint', 15:52:45 INFO - 'tpaint', 15:52:45 INFO - 'sessionrestore', 15:52:45 INFO - 'sessionrestore_no_auto_restore', 15:52:45 INFO - 'tabpaint']}, 15:52:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:52:45 INFO - 'tests': ['a11yr', 15:52:45 INFO - 'ts_paint', 15:52:45 INFO - 'tpaint', 15:52:45 INFO - 'sessionrestore', 15:52:45 INFO - 'sessionrestore_no_auto_restore', 15:52:45 INFO - 'tabpaint']}, 15:52:45 INFO - 'other_l64': {'tests': ['a11yr', 15:52:45 INFO - 'ts_paint', 15:52:45 INFO - 'tpaint', 15:52:45 INFO - 'sessionrestore', 15:52:45 INFO - 'sessionrestore_no_auto_restore', 15:52:45 INFO - 'tabpaint']}, 15:52:45 INFO - 'other_nol64': {'tests': ['a11yr', 15:52:45 INFO - 'ts_paint', 15:52:45 INFO - 'tpaint', 15:52:45 INFO - 'sessionrestore', 15:52:45 INFO - 'sessionrestore_no_auto_restore', 15:52:45 INFO - 'tabpaint']}, 15:52:45 INFO - 'svgr': {'tests': ['tsvgx', 15:52:45 INFO - 'tsvgr_opacity', 15:52:45 INFO - 'tart', 15:52:45 INFO - 'tscrollx', 15:52:45 INFO - 'cart']}, 15:52:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:52:45 INFO - 'tests': ['tsvgx', 15:52:45 INFO - 'tsvgr_opacity', 15:52:45 INFO - 'tart', 15:52:45 INFO - 'tscrollx', 15:52:45 INFO - 'cart']}, 15:52:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:45 INFO - 'tests': ['tp5o']}, 15:52:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:45 INFO - 'talos_options': ['--e10s'], 15:52:45 INFO - 'tests': ['tp5o']}, 15:52:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:45 INFO - 'talos_options': ['--xperf_path', 15:52:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:45 INFO - 'tests': ['tp5n']}, 15:52:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:45 INFO - 'talos_options': ['--e10s', 15:52:45 INFO - '--xperf_path', 15:52:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:45 INFO - 'tests': ['tp5n']}}, 15:52:45 INFO - 'talos.zip': {'path': '', 15:52:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:45 INFO - Running post-action listener: _resource_record_post_action 15:52:45 INFO - ##### 15:52:45 INFO - ##### Running create-virtualenv step. 15:52:45 INFO - ##### 15:52:45 INFO - Running pre-action listener: _resource_record_pre_action 15:52:45 INFO - Running main action method: create_virtualenv 15:52:45 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:52:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:45 INFO - Using real prefix '/usr' 15:52:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:45 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:47 INFO - Installing pip.................done. 15:52:47 INFO - Return code: 0 15:52:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:47 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 0x7fd7f2994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a8410>, '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 0x23a9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a97a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:52:47 INFO - Using env: {'DISPLAY': ':0', 15:52:47 INFO - 'HOME': '/home/cltbld', 15:52:47 INFO - 'LANG': 'en_US.UTF-8', 15:52:47 INFO - 'LANGUAGE': 'en_US:en', 15:52:47 INFO - 'LOGNAME': 'cltbld', 15:52:47 INFO - 'MAIL': '/var/mail/cltbld', 15:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:47 INFO - 'MOZ_NO_REMOTE': '1', 15:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:47 INFO - 'NO_EM_RESTART': '1', 15:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:47 INFO - 'PWD': '/builds/slave/test', 15:52:47 INFO - 'SHELL': '/bin/bash', 15:52:47 INFO - 'SHLVL': '1', 15:52:47 INFO - 'TERM': 'linux', 15:52:47 INFO - 'TMOUT': '86400', 15:52:47 INFO - 'USER': 'cltbld', 15:52:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 15:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:47 INFO - '_': '/tools/buildbot/bin/python'} 15:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:52:47 INFO - Cleaning up... 15:52:47 INFO - Return code: 0 15:52:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:47 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 0x7fd7f2994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a8410>, '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 0x23a9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a97a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:52:47 INFO - Using env: {'DISPLAY': ':0', 15:52:47 INFO - 'HOME': '/home/cltbld', 15:52:47 INFO - 'LANG': 'en_US.UTF-8', 15:52:47 INFO - 'LANGUAGE': 'en_US:en', 15:52:47 INFO - 'LOGNAME': 'cltbld', 15:52:47 INFO - 'MAIL': '/var/mail/cltbld', 15:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:47 INFO - 'MOZ_NO_REMOTE': '1', 15:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:47 INFO - 'NO_EM_RESTART': '1', 15:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:47 INFO - 'PWD': '/builds/slave/test', 15:52:47 INFO - 'SHELL': '/bin/bash', 15:52:47 INFO - 'SHLVL': '1', 15:52:47 INFO - 'TERM': 'linux', 15:52:47 INFO - 'TMOUT': '86400', 15:52:47 INFO - 'USER': 'cltbld', 15:52:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 15:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:47 INFO - '_': '/tools/buildbot/bin/python'} 15:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:48 INFO - Downloading/unpacking psutil>=0.7.1 15:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:50 INFO - Installing collected packages: psutil 15:52:50 INFO - Running setup.py install for psutil 15:52:50 INFO - building 'psutil._psutil_linux' extension 15:52:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:52:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:52:50 INFO - building 'psutil._psutil_posix' extension 15:52:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:52:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:50 INFO - Successfully installed psutil 15:52:50 INFO - Cleaning up... 15:52:50 INFO - Return code: 0 15:52:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:50 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 0x7fd7f2994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a8410>, '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 0x23a9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a97a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:52:50 INFO - Using env: {'DISPLAY': ':0', 15:52:50 INFO - 'HOME': '/home/cltbld', 15:52:50 INFO - 'LANG': 'en_US.UTF-8', 15:52:50 INFO - 'LANGUAGE': 'en_US:en', 15:52:50 INFO - 'LOGNAME': 'cltbld', 15:52:50 INFO - 'MAIL': '/var/mail/cltbld', 15:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:50 INFO - 'MOZ_NO_REMOTE': '1', 15:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:50 INFO - 'NO_EM_RESTART': '1', 15:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:50 INFO - 'PWD': '/builds/slave/test', 15:52:50 INFO - 'SHELL': '/bin/bash', 15:52:50 INFO - 'SHLVL': '1', 15:52:50 INFO - 'TERM': 'linux', 15:52:50 INFO - 'TMOUT': '86400', 15:52:50 INFO - 'USER': 'cltbld', 15:52:50 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 15:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:50 INFO - '_': '/tools/buildbot/bin/python'} 15:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:52:52 INFO - Installing collected packages: mozsystemmonitor 15:52:52 INFO - Running setup.py install for mozsystemmonitor 15:52:52 INFO - Successfully installed mozsystemmonitor 15:52:52 INFO - Cleaning up... 15:52:52 INFO - Return code: 0 15:52:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd7f2994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a8410>, '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 0x23a9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a97a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:52:52 INFO - Using env: {'DISPLAY': ':0', 15:52:52 INFO - 'HOME': '/home/cltbld', 15:52:52 INFO - 'LANG': 'en_US.UTF-8', 15:52:52 INFO - 'LANGUAGE': 'en_US:en', 15:52:52 INFO - 'LOGNAME': 'cltbld', 15:52:52 INFO - 'MAIL': '/var/mail/cltbld', 15:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:52 INFO - 'MOZ_NO_REMOTE': '1', 15:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:52 INFO - 'NO_EM_RESTART': '1', 15:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:52 INFO - 'PWD': '/builds/slave/test', 15:52:52 INFO - 'SHELL': '/bin/bash', 15:52:52 INFO - 'SHLVL': '1', 15:52:52 INFO - 'TERM': 'linux', 15:52:52 INFO - 'TMOUT': '86400', 15:52:52 INFO - 'USER': 'cltbld', 15:52:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 15:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:52 INFO - '_': '/tools/buildbot/bin/python'} 15:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:55 INFO - Downloading docopt-0.6.1.tar.gz 15:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:55 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:55 INFO - Running setup.py install for blobuploader 15:52:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:55 INFO - Running setup.py install for requests 15:52:56 INFO - Running setup.py install for docopt 15:52:56 INFO - Successfully installed blobuploader requests docopt 15:52:56 INFO - Cleaning up... 15:52:56 INFO - Return code: 0 15:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:56 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 0x7fd7f2994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a8410>, '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 0x23a9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a97a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:52:56 INFO - Using env: {'DISPLAY': ':0', 15:52:56 INFO - 'HOME': '/home/cltbld', 15:52:56 INFO - 'LANG': 'en_US.UTF-8', 15:52:56 INFO - 'LANGUAGE': 'en_US:en', 15:52:56 INFO - 'LOGNAME': 'cltbld', 15:52:56 INFO - 'MAIL': '/var/mail/cltbld', 15:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:56 INFO - 'MOZ_NO_REMOTE': '1', 15:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:56 INFO - 'NO_EM_RESTART': '1', 15:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:56 INFO - 'PWD': '/builds/slave/test', 15:52:56 INFO - 'SHELL': '/bin/bash', 15:52:56 INFO - 'SHLVL': '1', 15:52:56 INFO - 'TERM': 'linux', 15:52:56 INFO - 'TMOUT': '86400', 15:52:56 INFO - 'USER': 'cltbld', 15:52:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 15:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:56 INFO - '_': '/tools/buildbot/bin/python'} 15:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:56 INFO - Running setup.py (path:/tmp/pip-ByJLsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:56 INFO - Running setup.py (path:/tmp/pip-iLVfIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:56 INFO - Running setup.py (path:/tmp/pip-FPS0GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:56 INFO - Running setup.py (path:/tmp/pip-5cG2C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:56 INFO - Running setup.py (path:/tmp/pip-cAqxYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:56 INFO - Running setup.py (path:/tmp/pip-Dhux8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:57 INFO - Running setup.py (path:/tmp/pip-YRUito-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:57 INFO - Running setup.py (path:/tmp/pip-APjIWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:57 INFO - Running setup.py (path:/tmp/pip-oyHf1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:57 INFO - Running setup.py (path:/tmp/pip-WDEZVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:57 INFO - Running setup.py (path:/tmp/pip-s2TNLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:57 INFO - Running setup.py (path:/tmp/pip-aibIoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:57 INFO - Running setup.py (path:/tmp/pip-l6lEF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:57 INFO - Running setup.py (path:/tmp/pip-rBXJlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:57 INFO - Running setup.py (path:/tmp/pip-oGiack-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:57 INFO - Running setup.py (path:/tmp/pip-bkuBfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:57 INFO - Running setup.py (path:/tmp/pip-z7wxN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:57 INFO - Running setup.py install for manifestparser 15:52:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:57 INFO - Running setup.py install for mozcrash 15:52:58 INFO - Running setup.py install for mozdebug 15:52:58 INFO - Running setup.py install for mozdevice 15:52:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Running setup.py install for mozfile 15:52:58 INFO - Running setup.py install for mozhttpd 15:52:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Running setup.py install for mozinfo 15:52:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Running setup.py install for mozInstall 15:52:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Running setup.py install for mozleak 15:52:58 INFO - Running setup.py install for mozlog 15:52:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Running setup.py install for moznetwork 15:52:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Running setup.py install for mozprocess 15:52:59 INFO - Running setup.py install for mozprofile 15:52:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Running setup.py install for mozrunner 15:52:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Running setup.py install for mozscreenshot 15:52:59 INFO - Running setup.py install for moztest 15:52:59 INFO - Running setup.py install for mozversion 15:52:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:52:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:52:59 INFO - Cleaning up... 15:52:59 INFO - Return code: 0 15:52:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:59 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 0x7fd7f2994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a8410>, '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 0x23a9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a97a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:52:59 INFO - Using env: {'DISPLAY': ':0', 15:52:59 INFO - 'HOME': '/home/cltbld', 15:52:59 INFO - 'LANG': 'en_US.UTF-8', 15:52:59 INFO - 'LANGUAGE': 'en_US:en', 15:52:59 INFO - 'LOGNAME': 'cltbld', 15:52:59 INFO - 'MAIL': '/var/mail/cltbld', 15:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:59 INFO - 'MOZ_NO_REMOTE': '1', 15:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:59 INFO - 'NO_EM_RESTART': '1', 15:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:59 INFO - 'PWD': '/builds/slave/test', 15:52:59 INFO - 'SHELL': '/bin/bash', 15:52:59 INFO - 'SHLVL': '1', 15:52:59 INFO - 'TERM': 'linux', 15:52:59 INFO - 'TMOUT': '86400', 15:52:59 INFO - 'USER': 'cltbld', 15:52:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 15:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:59 INFO - '_': '/tools/buildbot/bin/python'} 15:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:59 INFO - Running setup.py (path:/tmp/pip-1g97FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:59 INFO - Running setup.py (path:/tmp/pip-BlXYOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:59 INFO - Running setup.py (path:/tmp/pip-_6UR3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:00 INFO - Running setup.py (path:/tmp/pip-jGNTaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:00 INFO - Running setup.py (path:/tmp/pip-mY8nrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:00 INFO - Running setup.py (path:/tmp/pip-miUCdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:00 INFO - Running setup.py (path:/tmp/pip-9LoXE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:00 INFO - Running setup.py (path:/tmp/pip-y6jmx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:00 INFO - Running setup.py (path:/tmp/pip-WIODZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:00 INFO - Running setup.py (path:/tmp/pip-akslyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:00 INFO - Running setup.py (path:/tmp/pip-2kck6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:00 INFO - Running setup.py (path:/tmp/pip-NKxvZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:00 INFO - Running setup.py (path:/tmp/pip-sqU6L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:00 INFO - Running setup.py (path:/tmp/pip-hx6RUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:00 INFO - Running setup.py (path:/tmp/pip-KJFege-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:00 INFO - Running setup.py (path:/tmp/pip-JGtdjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:01 INFO - Running setup.py (path:/tmp/pip-aW5RVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:02 INFO - Downloading blessings-1.6.tar.gz 15:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:03 INFO - Installing collected packages: blessings 15:53:03 INFO - Running setup.py install for blessings 15:53:03 INFO - Successfully installed blessings 15:53:03 INFO - Cleaning up... 15:53:03 INFO - Return code: 0 15:53:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:03 INFO - Reading from file tmpfile_stdout 15:53:03 INFO - Current package versions: 15:53:03 INFO - argparse == 1.2.1 15:53:03 INFO - blessings == 1.6 15:53:03 INFO - blobuploader == 1.2.4 15:53:03 INFO - docopt == 0.6.1 15:53:03 INFO - manifestparser == 1.1 15:53:03 INFO - mozInstall == 1.12 15:53:03 INFO - mozcrash == 0.17 15:53:03 INFO - mozdebug == 0.1 15:53:03 INFO - mozdevice == 0.48 15:53:03 INFO - mozfile == 1.2 15:53:03 INFO - mozhttpd == 0.7 15:53:03 INFO - mozinfo == 0.9 15:53:03 INFO - mozleak == 0.1 15:53:03 INFO - mozlog == 3.1 15:53:03 INFO - moznetwork == 0.27 15:53:03 INFO - mozprocess == 0.22 15:53:03 INFO - mozprofile == 0.28 15:53:03 INFO - mozrunner == 6.11 15:53:03 INFO - mozscreenshot == 0.1 15:53:03 INFO - mozsystemmonitor == 0.0 15:53:03 INFO - moztest == 0.7 15:53:03 INFO - mozversion == 1.4 15:53:03 INFO - psutil == 3.1.1 15:53:03 INFO - requests == 1.2.3 15:53:03 INFO - wsgiref == 0.1.2 15:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:03 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 0x7fd7f2994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a8410>, '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 0x23a9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a97a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:03 INFO - Using env: {'DISPLAY': ':0', 15:53:03 INFO - 'HOME': '/home/cltbld', 15:53:03 INFO - 'LANG': 'en_US.UTF-8', 15:53:03 INFO - 'LANGUAGE': 'en_US:en', 15:53:03 INFO - 'LOGNAME': 'cltbld', 15:53:03 INFO - 'MAIL': '/var/mail/cltbld', 15:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:03 INFO - 'MOZ_NO_REMOTE': '1', 15:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:03 INFO - 'NO_EM_RESTART': '1', 15:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:03 INFO - 'PWD': '/builds/slave/test', 15:53:03 INFO - 'SHELL': '/bin/bash', 15:53:03 INFO - 'SHLVL': '1', 15:53:03 INFO - 'TERM': 'linux', 15:53:03 INFO - 'TMOUT': '86400', 15:53:03 INFO - 'USER': 'cltbld', 15:53:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 15:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:03 INFO - '_': '/tools/buildbot/bin/python'} 15:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:53:03 INFO - Cleaning up... 15:53:03 INFO - Return code: 0 15:53:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:03 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 0x7fd7f2994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a8410>, '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 0x23a9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a97a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:53:03 INFO - Using env: {'DISPLAY': ':0', 15:53:03 INFO - 'HOME': '/home/cltbld', 15:53:03 INFO - 'LANG': 'en_US.UTF-8', 15:53:03 INFO - 'LANGUAGE': 'en_US:en', 15:53:03 INFO - 'LOGNAME': 'cltbld', 15:53:03 INFO - 'MAIL': '/var/mail/cltbld', 15:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:03 INFO - 'MOZ_NO_REMOTE': '1', 15:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:03 INFO - 'NO_EM_RESTART': '1', 15:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:03 INFO - 'PWD': '/builds/slave/test', 15:53:03 INFO - 'SHELL': '/bin/bash', 15:53:03 INFO - 'SHLVL': '1', 15:53:03 INFO - 'TERM': 'linux', 15:53:03 INFO - 'TMOUT': '86400', 15:53:03 INFO - 'USER': 'cltbld', 15:53:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 15:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:03 INFO - '_': '/tools/buildbot/bin/python'} 15:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:03 INFO - Downloading/unpacking jsonschema 15:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:05 INFO - Downloading/unpacking functools32 (from jsonschema) 15:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:05 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:05 INFO - warning: no files found matching '*.txt' 15:53:05 INFO - no previously-included directories found matching 'build' 15:53:05 INFO - no previously-included directories found matching 'dist' 15:53:05 INFO - no previously-included directories found matching '.git*' 15:53:05 INFO - Installing collected packages: jsonschema, functools32 15:53:06 INFO - Running setup.py install for functools32 15:53:06 INFO - warning: no files found matching '*.txt' 15:53:06 INFO - no previously-included directories found matching 'build' 15:53:06 INFO - no previously-included directories found matching 'dist' 15:53:06 INFO - no previously-included directories found matching '.git*' 15:53:06 INFO - Successfully installed jsonschema functools32 15:53:06 INFO - Cleaning up... 15:53:06 INFO - Return code: 0 15:53:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7f2994f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a8410>, '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 0x23a9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a97a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:53:06 INFO - Using env: {'DISPLAY': ':0', 15:53:06 INFO - 'HOME': '/home/cltbld', 15:53:06 INFO - 'LANG': 'en_US.UTF-8', 15:53:06 INFO - 'LANGUAGE': 'en_US:en', 15:53:06 INFO - 'LOGNAME': 'cltbld', 15:53:06 INFO - 'MAIL': '/var/mail/cltbld', 15:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:06 INFO - 'MOZ_NO_REMOTE': '1', 15:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:06 INFO - 'NO_EM_RESTART': '1', 15:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:06 INFO - 'PWD': '/builds/slave/test', 15:53:06 INFO - 'SHELL': '/bin/bash', 15:53:06 INFO - 'SHLVL': '1', 15:53:06 INFO - 'TERM': 'linux', 15:53:06 INFO - 'TMOUT': '86400', 15:53:06 INFO - 'USER': 'cltbld', 15:53:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 15:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:06 INFO - '_': '/tools/buildbot/bin/python'} 15:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:06 INFO - Downloading/unpacking flake8 15:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:53:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:53:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:53:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:08 INFO - no previously-included directories found matching 'docs/_build' 15:53:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:53:09 INFO - Running setup.py install for pep8 15:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:09 INFO - no previously-included directories found matching 'docs/_build' 15:53:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:53:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:53:09 INFO - Cleaning up... 15:53:09 INFO - Return code: 0 15:53:09 INFO - Running post-action listener: _resource_record_post_action 15:53:09 INFO - Running post-action listener: _start_resource_monitoring 15:53:09 INFO - Starting resource monitoring. 15:53:09 INFO - ##### 15:53:09 INFO - ##### Running install step. 15:53:09 INFO - ##### 15:53:09 INFO - Running pre-action listener: _resource_record_pre_action 15:53:09 INFO - Running main action method: install 15:53:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:09 INFO - Reading from file tmpfile_stdout 15:53:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:09 INFO - Reading from file tmpfile_stdout 15:53:09 INFO - Output received: 15:53:09 INFO - Usage: mozinstall [options] installer 15:53:09 INFO - Options: 15:53:09 INFO - -h, --help show this help message and exit 15:53:09 INFO - -d DEST, --destination=DEST 15:53:09 INFO - Directory to install application into. [default: 15:53:09 INFO - "/builds/slave/test"] 15:53:09 INFO - --app=APP Application being installed. [default: firefox] 15:53:09 INFO - mkdir: /builds/slave/test/build/application 15:53:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:53:25 INFO - Reading from file tmpfile_stdout 15:53:25 INFO - Output received: 15:53:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:53:25 INFO - Running post-action listener: _resource_record_post_action 15:53:25 INFO - ##### 15:53:25 INFO - ##### Running run-tests step. 15:53:25 INFO - ##### 15:53:25 INFO - Running pre-action listener: _resource_record_pre_action 15:53:25 INFO - Running main action method: run_tests 15:53:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:25 INFO - Python 2.7.3 15:53:25 INFO - Return code: 0 15:53:25 INFO - grabbing minidump binary from tooltool 15:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:25 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 0x23a8410>, '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 0x23a9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:53:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:53:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:25 INFO - Return code: 0 15:53:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:53:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:53:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:53:26 INFO - Return code: 0 15:53:26 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/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:53:26 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/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:53:26 INFO - Using env: {'DISPLAY': ':0', 15:53:26 INFO - 'HOME': '/home/cltbld', 15:53:26 INFO - 'LANG': 'en_US.UTF-8', 15:53:26 INFO - 'LANGUAGE': 'en_US:en', 15:53:26 INFO - 'LOGNAME': 'cltbld', 15:53:26 INFO - 'MAIL': '/var/mail/cltbld', 15:53:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:26 INFO - 'MOZ_NO_REMOTE': '1', 15:53:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:26 INFO - 'NO_EM_RESTART': '1', 15:53:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:26 INFO - 'PWD': '/builds/slave/test', 15:53:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:26 INFO - 'SHELL': '/bin/bash', 15:53:26 INFO - 'SHLVL': '1', 15:53:26 INFO - 'TERM': 'linux', 15:53:26 INFO - 'TMOUT': '86400', 15:53:26 INFO - 'USER': 'cltbld', 15:53:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424', 15:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:26 INFO - '_': '/tools/buildbot/bin/python'} 15:53:26 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/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:53:26 INFO - mozversion application_buildid: 20160405145306 15:53:26 INFO - mozversion application_changeset: b3eed99cb17bc8d6e6eda1a6f4ecb53fd1b30a43 15:53:26 INFO - mozversion application_display_name: Nightly 15:53:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:26 INFO - mozversion application_name: Firefox 15:53:26 INFO - mozversion application_remotingname: firefox 15:53:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:53:26 INFO - mozversion application_vendor: Mozilla 15:53:26 INFO - mozversion application_version: 48.0a1 15:53:26 INFO - mozversion platform_buildid: 20160405145306 15:53:26 INFO - mozversion platform_changeset: b3eed99cb17bc8d6e6eda1a6f4ecb53fd1b30a43 15:53:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:53:26 INFO - mozversion platform_version: 48.0a1 15:53:26 INFO - using testdate: 1459896806 15:53:26 INFO - actual date: 1459896806 15:53:26 INFO - starting webserver on 'localhost:46975' 15:53:26 INFO - SUITE-START | Running 2 tests 15:53:26 INFO - TEST-START | dromaeo_css 15:53:26 INFO - operating with platform_type : linux_ 15:53:26 INFO - Initialising browser for dromaeo_css test... 15:53:26 INFO - TEST-INFO | started process 15994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbcJhgb/profile http://localhost:46975/getInfo.html) 15:53:31 INFO - PROCESS | 15994 | __metrics Screen width/height:1600/1200 15:53:31 INFO - PROCESS | 15994 | colorDepth:24 15:53:31 INFO - PROCESS | 15994 | Browser inner width/height: 1024/697 15:53:31 INFO - PROCESS | 15994 | __metrics 15:53:32 ERROR - PROCESS | 15994 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:53:32 INFO - TEST-INFO | 15994: exit 0 15:53:32 INFO - Browser initialized. 15:53:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:53:32 INFO - TEST-INFO | started process 16075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbcJhgb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:44 INFO - PROCESS | 16075 | RSS: Main: 154832896 15:53:44 INFO - PROCESS | 16075 | 15:54:35 INFO - PROCESS | 16075 | 1459896875874 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:56:48 INFO - PROCESS | 16075 | Cycle 1(1): loaded http://localhost:46975/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46975/tests/dromaeo/cssquery-ext.html) 15:56:49 INFO - PROCESS | 16075 | RSS: Main: 247824384 15:56:49 INFO - PROCESS | 16075 | 15:59:51 INFO - PROCESS | 16075 | Cycle 1(1): loaded http://localhost:46975/tests/dromaeo/cssquery-ext.html (next: http://localhost:46975/tests/dromaeo/cssquery-jquery.html) 15:59:52 INFO - PROCESS | 16075 | RSS: Main: 231956480 15:59:52 INFO - PROCESS | 16075 | 16:02:54 INFO - PROCESS | 16075 | Cycle 1(1): loaded http://localhost:46975/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46975/tests/dromaeo/cssquery-mootools.html) 16:02:54 INFO - PROCESS | 16075 | RSS: Main: 230084608 16:02:54 INFO - PROCESS | 16075 | 16:05:56 INFO - PROCESS | 16075 | Cycle 1(1): loaded http://localhost:46975/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46975/tests/dromaeo/cssquery-prototype.html) 16:05:57 INFO - PROCESS | 16075 | RSS: Main: 221196288 16:05:57 INFO - PROCESS | 16075 | 16:09:00 INFO - PROCESS | 16075 | Cycle 1(1): loaded http://localhost:46975/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46975/tests/dromaeo/cssquery-yui.html) 16:09:00 INFO - PROCESS | 16075 | RSS: Main: 204345344 16:09:00 INFO - PROCESS | 16075 | 16:12:03 INFO - PROCESS | 16075 | Cycle 1(1): loaded http://localhost:46975/tests/dromaeo/cssquery-yui.html (next: http://localhost:46975/tests/dromaeo/cssquery-dojo.html) 16:12:03 INFO - PROCESS | 16075 | RSS: Main: 266924032 16:12:03 INFO - PROCESS | 16075 | 16:12:03 INFO - PROCESS | 16075 | __start_tp_report 16:12:03 INFO - PROCESS | 16075 | _x_x_mozilla_page_load 16:12:03 INFO - PROCESS | 16075 | _x_x_mozilla_page_load_details 16:12:03 INFO - PROCESS | 16075 | |i|pagename|runs| 16:12:03 INFO - PROCESS | 16075 | |0;dojo.html;2592.0539003263807;2663.5072511585345;2669.5728683410634;2677.692065412477;2690.878910449029;4539.9773001134945;4616.676832621718;4707.058588282344;4710.717356958585;4718.858434246974;4650.534946505348;4651.883702907429;4712.0811441768865;4719.292106184074;4735.266033764763;4300.096979634272;4312.762798046107;4326.913461730764;4354.782260886959;4461.955380446203;4377.562243775629;4423.867283981485;4441.866743997685;4447.777611119447;4448.377227188196;4245.830166793325;4251.44731184944;4311.525732169459;4324.978375108136;4338.1540599583095;4266.189424009459;4268.146370725836;4286.057067445157;4317.870463886088;4326.545712700184;4248.745075295492;4253.893652658678;4255.8084886180195;4292.227399068166;4298.570142985708;4501;4509.661775366828;4544.068465964469;4566.337881007268;4609.124266389375;4941.629377796679;4949.232868905326;4958.057968985881;4978.079055374767;4983.127952608279;4975.601951843843;4987.476314986947;4989.550940415344;4996.675216110941;5036.949630503721;4548.408706868086;4578.313253012008;4619.1685496610935;4646.744429056401;4699.624030077552;5127.384713834289;5127.66670166438;5147.3051138096625;5149.176131818891;5173.9999999999245;4920.360353154067;4920.5571498565305;4925.507449255046;4927.187014142698;4957.132501812169;4846.80612775492;4954.232094025432;4995.100881841231;5030.446650868402;5039.622028347889;4943.826966056171;4946.109700253989;4961.42943561495;4961.5286547777905;5011.3986321640905;4962.057209130326;4962.8833512459405;4963.808685915426;4966.826161084345;5006;4225.9788701056295;4283.485981682218;4286.249906266391;4286.5284818669925;4288;3690.9815450922574;3734.6638802507905;3752.5684546277525;3753.230587729509;3776.4335349697767;4250.681198910094;4301.225779359683;4351.36905148758;4352.912941741148;4363.672724545609;5031.320771695848;5038.420581633086;5039.622028347889;5048.0913435581215;5063.8480845574695;4252.681048921281;4273.995611031405;4337.9132417351475;4340.066885619607;4370.060437006059;4519;4526.683132180716;4532.456105267323;4564.2012647786505;4581.015081757439;4685.8594242172785;4688.390509233915;4702.835400760957;4704.858854234379;4758.04839032188;4920.163572192808;4948.950510494849;4960.181570040902;4964.429090654621;5032.471590482946;4702.365180700562;4720.103180395714;4723.338732577373;4744.169770290255;4763.214069678603;4895.975520122377;4898.363212782316;4900.191468407816;4904.166291730486;4946;4821.4696383397095;4968.453470118357;4995.125852975642;5059.848204553869;5081.4918508148885;4771.260454629538;4777.378940737682;4788.856334309976;4791.976040119777;4836.516348365135;4793.616510679207;4803.759812009315;4807.855764327076;4811.133995880775;4856.757162141808;4647.65142614312;4728.007118505152;4748;4771.165046116985;4812.494688057844;4818.807247710052;4820.9517904820505;4827.227643577011;4849.224124140121;4888.2178851383605;4703.435587729495;4725.385699858996;4755.548222918817;4758.928616070692;4791.976040119777 16:12:03 INFO - PROCESS | 16075 | |1;ext.html;523.1237676891207;524.6930545630805;525.0575217484615;531.6836482293035;545.0189658614493;26981.055663051797;27494.587581186297;34587.82706086469;35333;35532.11169720758;38030.809845950804;38590.8070459648;38599.42100868489;38615.80692096543;38626.61373386265;7718.035245594287;7913.248241417056;7917.208279172094;7917.920820791776;7920.524768513878;7750.612469376509;7838.412119091063;7863.882041769378;7876.212378762135;7882.408819338544;8046.5976701165;8124.512529248234;8132.634031468599;8151.021877374694;8154.836903261931;8022.438429309951;8085.474444161169;8104.189581041907;8104.311133553655;8104.6352914118415;7939.404544659116;8044.517328960281;8074.232947870002;8078.838423231502;8084.757457276232;38850;38975.610243897485;39014.804925975186;39219.803900980594;39302.410463843065;3227.467467867799;3242.319112986252;3284.1953721338423;3534.6642069003406;3890.688744900401;29405.85297073501;29421.264468388246;29694.851525742448;29793.25516862074;29867;3465.8440370183403;3518;3518.982405087984;3599.7660152090293;3602.225521512887;184213;185233;185263;185267.07366463082;186079;44084.559154408686;44644.330335045;44666;55874;57433.425665742805;40584.59415405867;40650.59349406527;40750.59249407468;40875.7956210223;40918;15021.924890375478;15153.54539363821;15180.316885740169;15186.240687965557;15188.924055379874;11268.661940141645;11284.887151128547;11300.20898537111;11303.03924166455;11305.208635395607;15143.469978550698;15156.772648410282;15175.772363414557;15204.695906081817;15327.31027103783;5522.337319521683;5624.634398764068;5699.2590963174525;5774.881563955417;5853.0635098384055;875.8335916175906;883.3639779358851;1017.3590637898225;1025.1418013489729;1044.3785947361307;26971.325716857235;27104.32239194036;27182.45635087287;27269.863650682015;27513.72486275152;969.9175570076623;996.6511720897628;1026.5329275179774;1052.1898138433517;1059.131512160037;14094.436222550983;14484.927575362055;14565.344559494848;14893.77659335111;14925.925370373296;292021;294974;295708;295871;295878;47686.28470572944;48637.513624864005;48722;48745.75627121913;48764.26853597199;1108.9611863584735;1218.469965564982;1251.8122281657825;1253.4798058805493;1309.2210134969678;24417;25378.492430151662;25709.35726606775;25782.742172578033;25828.225153245432;38635.420468693555;38993.80503097466;39247.80376098101;39320;39367.606323937536;203046;203254;203518;203590;203796;26805.195844124708;31461;31527.84236078805;31682;32241.51637725389;36398.27203455863;36507.81746091359;37161.256774864894;37438.251234975694;37507.2498550022;33216.335673286885;33218.50172247466;33622.327553449286;33773.3245335087;34818.12954676052;33113.66886331106;33512.83243583766;33700.15749606279;34063.65936340605;34235.828820855735;34000.82999585085;34030;34308.14229644279;34633;37418.625813742605;26979.460410792068;30585.23536911506;30798.69201307958;30811.691883081778;31124.68875311218;24444.14445494399;24893.377665558506;25284.620730688686;25600.231993040237;26114.477710446066 16:12:03 INFO - PROCESS | 16075 | |2;jquery.html;327.17388593800644;331.7047827433584;344.10704222542495;354.5444104325942;357.412057165962;15094.62263443413;15562.45531406401;16129;16872.409465668705;16886.74669879953;16275.83724162758;16309.673806523862;16716.331346746145;17087.145642717845;17157.313707451718;4770.379850619414;4968.006398720252;4971.105201063807;4988.4762099979525;5234.895302093956;5380.542653874406;5386.946130538684;5418.593605479585;5418.783248670048;5426;5358.142697168454;5396.595255355864;5404.270423492837;5405.027095122877;5406.405295417501;5331;5388.110961691316;5415.13357862742;5463.590230732711;5470.17947307903;5253.264542963988;5261.710605916673;5321.787128514855;5322.175062865262;5332.093544097474;11736.88263117375;11741.29552226869;11751.059915206848;11764.058875289957;11972.58095966637;1909.1313452379134;1947.7175809507685;1966.3412756726514;2229.765874583162;2257.4694946687514;9222.631094756201;9333.393329433566;9580.90419095807;9838.704838854774;12947.546835860794;1756.3764863473539;1813.3834496271331;1847.187237615445;1872.3353209610664;1928.498590366515;56391.71804140994;58050;58336;58589.707051465324;59040.70479647617;9677.274204434696;9772.902270977342;9833.704988850346;9894.356866803635;9941.19028465489;13343.66640833987;13346.332683365792;13396.665083372995;13436.664083397798;13471.191728496322;7349.522281051822;7429.925700742923;7449.962750186214;7559.886601700979;7571.318581327707;7132.500724949307;7166;7244.963775181196;7295.489315747953;7321.78034658961;4236.4704411948505;4237.173751118564;4238.198765524639;4303.655707543389;4308.289132293136;1781.518989872753;1796.5329014456074;1797.5685835399672;1806.8554515638718;1834.3763120539081;850.6469815026694;862.5600943518725;920.6041402196986;930.9115634014757;974.6442548469757;15808.130552819475;16037.679246415006;16083.758743618855;16147.273372698257;16205.351785928666;856.9485830850169;869.7782065573239;879.4151888993875;895.1048951048951;898.793277546168;8848.159424854628;9043.276537876955;9124.17882390588;9310.301727370474;9388;370205;374371;377088;378558;380310;63776.36223637797;66721.66639166774;67277.32722672711;68121.65939170272;68847.65576172087;931.380631879806;940.4921342474987;953.7853982853941;963.9325247232766;968.5447839515416;14265.42938282457;14412.711745765235;14607.853921461074;14731;14808.111513309235;32719.836400817843;32896.342073158885;33157.33685326231;33194.5020824683;33422.164445889044;40807.1838563233;43941;44598.331025034;44760;45465.545344547456;7397.223291554525;7424.257574242532;7515;7524.661390237343;7606.733764318223;8537.286280468017;11511;11779.412423863429;11846.348450834943;12061.879381206427;10360.689179324632;10373.987613149227;10413.219008574235;10500.212484063879;10605.204609654153;9503.619855205714;10395.16838652921;10422;10431.94784026075;10667.306625069346;10510.421926794099;10541.57833686644;10602.681919542427;10659.94670026645;10680.519376627915;7452.962735186289;7466.962665186639;7544.66049027806;7604.201558836464;7724.961375193088;8779.297656187617;10395.792084158425;10528;10593.364398136137;10647.627333043307 16:12:03 INFO - PROCESS | 16075 | |3;mootools.html;1259.3640211693094;1362.8023936529203;1365.9726805463895;1449.8042764226827;1662.3516828436912;6980.7207711691535;7134.143902731679;7138.928610713891;7157.427405807536;7161.212266650664;7020.929790702092;7179.641017949095;7183.856322873539;7195.208527062019;7202.279772022795;1855.8144185581402;2131.8827464489445;2164.0802658869957;2178.18318130701;2196.253273886878;2181.334692918659;2183.1049269799387;2190.9014094365793;2194.078487035449;2194.5281764420647;2079.241077006897;2162.9891850540725;2163.026638012893;2164.3615133535645;2169.208238992764;2094.0576740466777;2095.476130967258;2106.2312256026594;2175.3147758456034;2179.24815938501;2118.8093071623475;2132.797384248494;2140.475583482041;2141.486043349585;2143.3248526714037;7267.236940121264;7321.633918304064;7333.523320984119;7344.412447004281;7349.081364829396;4394.62645675118;4533.38799262102;4564.2240819060835;4570.177368073745;4585.243434833248;2911.213972227508;2947.7936544441895;3001.1746769638307;3014.6834582368756;3023.1232942446886;956.2541217850088;958.9232861371144;968.6706519783307;991.9553620087113;996.3822430093317;10012.29913906027;10014;10031.498425078717;10032.94983525085;10062.547185376676;4026.4095682205366;4161.729487583298;4165.791710414467;4184.790760461965;4230.365445183185;8456.365772567082;8472.915270847336;8482.787930301669;8486.448380855225;8497.532635705096;3850.133719912997;4569.200389931749;4575.24508456101;4605.148047611203;4606.631469482433;3971.2653159165648;3991.481107456012;4004.279229738675;4005.2790497710694;4010.5387880393546;3464.7401444891734;3486.38988177068;3514;3560.394732895414;3562.59030211529;1129.6444266879778;1132.6092498088146;1138.618562781461;1141.1270378160714;1141.680329507739;1118.0440723181562;1119.0711709281277;1135.784201001807;1157.7742340243572;1200.255841378351;6783.694733736895;6935.514513983972;6941.548799328028;6988.371046605728;7001;454.5590776946357;462.81024779840106;464.7745843266013;467.4810959834581;467.94384673838675;5135.2553879687985;5154.407243167008;5188.45521220274;5204.375474943031;5206.062908676475;7895.723649672349;7996.9200307997335;8529.14708529142;8830.161134692195;8875.822483550422;7905.920940790634;7949;7960.522368657899;7960.761177164694;8037.437379383504;6405.135306733625;6434.806955791334;6494.415502604694;6551.377619126175;6560;6749.493787965824;6846.863062738617;6859.039734437083;6864.4165245954655;6873.072135261676;7739.3421559165845;7863.724769633035;7990.360771138178;8015.639296231567;8103.878441823495;8119.959400203197;8120.959395202986;8300.750977470685;8301.543415112226;8302.584870756316;5597.888042239214;5660.7169641518585;5729.3984131665575;6603.075569420381;6727.461803055841;6032.328595970577;6468.773592924225;6468.870622587616;6973.6164510952385;6975.546589471668;6259.3427690091885;6269.717862696099;6360.840978975562;6430.871382572229;6456.741730330734;6245.6252624842655;6249.0626406039455;6312.558120931674;6335.1447554579545;6346.270178929482;6402.423781859655;6527.445167160845;6531;6672.733090676513;6690.330966903465;6024.156618073385;6054.666993315233;6058.727357269022;6070.423309785563;6071.453569178795;6005.879882402415;6126.050462178369;6173.259208894961;6208.410201030895;6223.657698826608 16:12:03 INFO - PROCESS | 16075 | |4;prototype.html;319.4680856374137;323.19363188843835;323.90606724050036;328.78957467220965;330.2173847980287;5434.945650543494;5447.645903016301;5481.75332110055;5486.259354987075;5541.556675465963;5464.890702185954;5471.917921231185;5473.644213126154;5474.91787623185;5481.588880833933;4074.8166332515034;4167.874963751077;4242.809073591696;4251.362295655661;4260.339647354649;4257.297545904922;4272.572742725733;4274.252005898955;4294.570542945712;4303.462067241595;4068.5117785865737;4270.12462445198;4270.210011147948;4275.166342563201;4279.7860106994685;4130.607592278729;4260.9147817043795;4271.551487093841;4271.765052922088;4278.700490965633;3767.6232376762377;3769.189624230776;3775.5846856845724;3783.4703141560203;3788.1855401088897;5267.525922666979;5269.262303277545;5269.736513174326;5273.156294992821;5278.419373868871;4919.3604831371695;4931.65478416511;4933.950660493385;4937.604991600663;4938.950610493885;5738.512226460756;5750.79872204475;5752.769889204426;5762.625429347079;5764.913526297109;3997.560268370477;4145.937810932838;4163.167366526707;4164.479440069991;4169.1661667666585;5973.223480947492;6025.487833534155;6031.0048841941025;6060.606060606091;6068.939310606882;4225.112726327444;4244.808983595745;4252.872413827528;4254.276772948606;4255.659547236276;4318.848840290638;4321.438213032286;4322;4323.437953066082;4326.026644005074;4896.436909755424;4907.509249075135;4912.631552633567;4914.140025495524;4916.0905232532095;5768.394318596571;5771.0477771168125;5776.797812076557;5783.248177736868;5788.18965344852;1490.3665941974834;1513.523240179362;1527.3203424476224;1533.0954736705398;1533.8879312498573;966.3573723473811;1019.261035749076;1019.3985548526405;1024.9743756406149;1037.1754455208127;4942.629302802232;4967.155583550805;4990.750462476862;4999.275105109738;5000.824971126066;5935;5953.851153721192;5956.791512297049;5964.224650795369;5965.194698715704;4970;4983.551480366785;4984.7258400788305;4989.80040798364;5001.274815151783;3156.179393357698;3188.218886372807;3192.776505644629;3193.473076942325;3199.232184275757;5331.546818520469;5495.917561236584;5499.835004949858;5511.200875873056;5513.972430137824;6001.099835024781;6005.939940600538;6013.639181649115;6014;6029.125776762345;5489.451054894478;5490;5509.641873278224;5510.504054635022;5511.4213007633625;5893.057110862242;5897.7935772247765;5899.144624029577;5904.173415721888;5906.202662640489;5716.9142462862255;5759.337676167294;5773.3072031356505;5774.595778295479;5775.422457754191;5362.5441837442695;5492.176173573996;5494.1758736189895;5496.80761173357;5504.146857237135;4096.365063415175;4097.631213190827;4125.401816736617;4130.752154870717;4137.151883863861;5974.6713930732485;5981.461668449861;5981.820545383645;5992.700364981646;5993.550483713651;5739.339975902824;5748.798792042258;5750.6837123958585;5751.568632352507;5751.798687046101;5745.425457454221;5746.856328591652;5749.885002300014;5752.424757524214;5754.309482862083;5470.206820011155;5570.4151064139305;5664.320281566073;5666.886662266649;5680.801171958961;5730.684812335361;5733.885322293448;5738.540916726735;5741.827745167651;5828.242328497268;5670.319561652628;5672.035753921926;5689;5691.231683722644;5692.658440493584 16:12:03 INFO - PROCESS | 16075 | |5;yui.html;692.8406466512699;723.1286300008487;726.9927300726991;745.7986343687203;763.4236151705462;13611.795823062663;13798.448062077505;13832.792508112374;13849.930750346233;13852.099613525113;13432.32838358083;13487.730245395087;13757.243351615682;13971.091879027856;14020.088694234868;640.1837656987332;805.2752522729531;807.6405999330315;823.6787652815377;825.1294883897485;824.2293455619016;827.5944787054331;827.8634025385804;827.9296259817893;828.4449418889359;850.5024560632007;859.2095272349422;860.3805260212637;861.3109512390095;862.4006315610621;663.3731124087739;836.1471299274706;847.8728190771373;850.808568072185;854.0520022774715;627.137685682187;627.8053803320939;628.0171531553104;628.5914155798722;629.468099455959;12810.551630692975;12856.935715321457;12882.484700611963;12893.161944473579;12893.290869002201;11748.471318790675;11758.706032349173;12036.939815300955;12337.50649974009;12453.813192802116;9781.559829807677;9886.258530610234;10060.647877324333;10072.143867771249;10293.691189264335;4106.609872062149;4132.380142978547;4172.290710579209;4201.264778663753;4329.307310830283;39729.40405893914;40163.39754903679;40180.79909600433;40233.39649905283;40241.59758402437;9572.377795443273;9597.184239339595;9769.804603907882;9789.167920726817;9955.50222488887;16453;16474.258658360402;16498.75251871223;16676.74984875228;16832.158392080346;6923.930760692429;6933.0293758873795;6952.7218911244;7003.8599228015155;7022.613756243353;3721.702263818888;3731.7574357666663;3815.198808250243;3877.3214687429586;3926.6466018058513;2777.416742484101;2813.099808061401;2817.7604903583424;2826.943461130766;2829.9812067655625;511.8464460661861;512.674451723151;512.7923191107608;513.4147072337538;528.2050513976518;614.2506142506224;619.4270299972508;636.2333388267127;645.9935400646027;653.8921078022073;7911.129775724666;7982.920170798334;8391.622297455177;8492.74521764348;8531;624.1698540940538;624.3787431505681;627.8273474794377;635.4249404289126;642.6915080761261;3342.5821772278464;3415.9146021349666;3421.794692318419;3479.1650003999366;3492.7205823534564;46757.766211168724;47231.527684722714;49647.50352496501;49936.750316248916;49978;43237.56762432399;43589.78205109017;43742;44092.118157636665;44141;39064.609353906664;39401.80299098486;39432;39679.00802480019;39822.40266396006;6063.848403789941;6185.195924529782;6613.768518101843;6652.966735166293;6695.330466953265;29661.85169074141;29698;30079;30969.380612388075;30997.535036974914;38998;39487.60512394839;40451.797741011105;40458.79770601128;40544.79727601343;9711.902880971382;10142.847174457136;10299;10623.203259755395;10705.839412408664;10954.698725979211;11023.724406889893;11201;11233.66299011031;11288.604898828502;10583.735406614896;10725.624603138853;10763.085137763377;10857.565697372016;11168.66494005181;10323.535440905027;10531.736706582396;10570.630027948984;10839.187060970302;10896.509657065293;10617.29130076694;10638.977316953831;10782.838257426301;10848.349099054081;10928.453577320943;8781.429207101519;9008.86486702713;9162.175404213385;9173.633054677739;9206.17144457002;8428.585627671157;8937.374383793072;8963.282937364866;9434.858477122985;9633.217854696904 16:12:03 INFO - PROCESS | 16075 | __end_tp_report 16:12:03 INFO - PROCESS | 16075 | __start_cc_report 16:12:03 INFO - PROCESS | 16075 | _x_x_mozilla_cycle_collect,859 16:12:03 INFO - PROCESS | 16075 | __end_cc_report 16:12:03 INFO - PROCESS | 16075 | __startTimestamp1459897923416__endTimestamp 16:12:03 INFO - PROCESS | 16075 | 16:12:03 INFO - PROCESS | 16075 | ------- Summary: start ------- 16:12:03 INFO - PROCESS | 16075 | Number of tests: 6 16:12:03 INFO - PROCESS | 16075 | 16:12:03 INFO - PROCESS | 16075 | [#0] dojo.html Cycles:165 Average:4613.21 Median:4723.34 stddev:465.60 (9.9%) stddev-sans-first:439.20 16:12:03 INFO - PROCESS | 16075 | Values: 2592.1 2663.5 2669.6 2677.7 2690.9 4540.0 4616.7 4707.1 4710.7 4718.9 4650.5 4651.9 4712.1 4719.3 4735.3 4300.1 4312.8 4326.9 4354.8 4462.0 4377.6 4423.9 4441.9 4447.8 4448.4 4245.8 4251.4 4311.5 4325.0 4338.2 4266.2 4268.1 4286.1 4317.9 4326.5 4248.7 4253.9 4255.8 4292.2 4298.6 4501.0 4509.7 4544.1 4566.3 4609.1 4941.6 4949.2 4958.1 4978.1 4983.1 4975.6 4987.5 4989.6 4996.7 5036.9 4548.4 4578.3 4619.2 4646.7 4699.6 5127.4 5127.7 5147.3 5149.2 5174.0 4920.4 4920.6 4925.5 4927.2 4957.1 4846.8 4954.2 4995.1 5030.4 5039.6 4943.8 4946.1 4961.4 4961.5 5011.4 4962.1 4962.9 4963.8 4966.8 5006.0 4226.0 4283.5 4286.2 4286.5 4288.0 3691.0 3734.7 3752.6 3753.2 3776.4 4250.7 4301.2 4351.4 4352.9 4363.7 5031.3 5038.4 5039.6 5048.1 5063.8 4252.7 4274.0 4337.9 4340.1 4370.1 4519.0 4526.7 4532.5 4564.2 4581.0 4685.9 4688.4 4702.8 4704.9 4758.0 4920.2 4949.0 4960.2 4964.4 5032.5 4702.4 4720.1 4723.3 4744.2 4763.2 4896.0 4898.4 4900.2 4904.2 4946.0 4821.5 4968.5 4995.1 5059.8 5081.5 4771.3 4777.4 4788.9 4792.0 4836.5 4793.6 4803.8 4807.9 4811.1 4856.8 4647.7 4728.0 4748.0 4771.2 4812.5 4818.8 4821.0 4827.2 4849.2 4888.2 4703.4 4725.4 4755.5 4758.9 4792.0 16:12:03 INFO - PROCESS | 16075 | 16:12:03 INFO - PROCESS | 16075 | [#1] ext.html Cycles:180 Average:38641.98 Median:34149.74 stddev:60667.63 (177.7%) stddev-sans-first:60770.31 16:12:03 INFO - PROCESS | 16075 | Values: 523.1 524.7 525.1 531.7 545.0 26981.1 27494.6 34587.8 35333.0 35532.1 38030.8 38590.8 38599.4 38615.8 38626.6 7718.0 7913.2 7917.2 7917.9 7920.5 7750.6 7838.4 7863.9 7876.2 7882.4 8046.6 8124.5 8132.6 8151.0 8154.8 8022.4 8085.5 8104.2 8104.3 8104.6 7939.4 8044.5 8074.2 8078.8 8084.8 38850.0 38975.6 39014.8 39219.8 39302.4 3227.5 3242.3 3284.2 3534.7 3890.7 29405.9 29421.3 29694.9 29793.3 29867.0 3465.8 3518.0 3519.0 3599.8 3602.2 184213.0 185233.0 185263.0 185267.1 186079.0 44084.6 44644.3 44666.0 55874.0 57433.4 40584.6 40650.6 40750.6 40875.8 40918.0 15021.9 15153.5 15180.3 15186.2 15188.9 11268.7 11284.9 11300.2 11303.0 11305.2 15143.5 15156.8 15175.8 15204.7 15327.3 5522.3 5624.6 5699.3 5774.9 5853.1 875.8 883.4 1017.4 1025.1 1044.4 26971.3 27104.3 27182.5 27269.9 27513.7 969.9 996.7 1026.5 1052.2 1059.1 14094.4 14484.9 14565.3 14893.8 14925.9 292021.0 294974.0 295708.0 295871.0 295878.0 47686.3 48637.5 48722.0 48745.8 48764.3 1109.0 1218.5 1251.8 1253.5 1309.2 24417.0 25378.5 25709.4 25782.7 25828.2 38635.4 38993.8 39247.8 39320.0 39367.6 203046.0 203254.0 203518.0 203590.0 203796.0 26805.2 31461.0 31527.8 31682.0 32241.5 36398.3 36507.8 37161.3 37438.3 37507.2 33216.3 33218.5 33622.3 33773.3 34818.1 33113.7 33512.8 33700.2 34063.7 34235.8 34000.8 34030.0 34308.1 34633.0 37418.6 26979.5 30585.2 30798.7 30811.7 31124.7 24444.1 24893.4 25284.6 25600.2 26114.5 16:12:03 INFO - PROCESS | 16075 | 16:12:03 INFO - PROCESS | 16075 | [#2] jquery.html Cycles:180 Average:22719.27 Median:44679.17 stddev:61711.35 (138.1%) stddev-sans-first:61861.56 16:12:03 INFO - PROCESS | 16075 | Values: 327.2 331.7 344.1 354.5 357.4 15094.6 15562.5 16129.0 16872.4 16886.7 16275.8 16309.7 16716.3 17087.1 17157.3 4770.4 4968.0 4971.1 4988.5 5234.9 5380.5 5386.9 5418.6 5418.8 5426.0 5358.1 5396.6 5404.3 5405.0 5406.4 5331.0 5388.1 5415.1 5463.6 5470.2 5253.3 5261.7 5321.8 5322.2 5332.1 11736.9 11741.3 11751.1 11764.1 11972.6 1909.1 1947.7 1966.3 2229.8 2257.5 9222.6 9333.4 9580.9 9838.7 12947.5 1756.4 1813.4 1847.2 1872.3 1928.5 56391.7 58050.0 58336.0 58589.7 59040.7 9677.3 9772.9 9833.7 9894.4 9941.2 13343.7 13346.3 13396.7 13436.7 13471.2 7349.5 7429.9 7450.0 7559.9 7571.3 7132.5 7166.0 7245.0 7295.5 7321.8 4236.5 4237.2 4238.2 4303.7 4308.3 1781.5 1796.5 1797.6 1806.9 1834.4 850.6 862.6 920.6 930.9 974.6 15808.1 16037.7 16083.8 16147.3 16205.4 856.9 869.8 879.4 895.1 898.8 8848.2 9043.3 9124.2 9310.3 9388.0 370205.0 374371.0 377088.0 378558.0 380310.0 63776.4 66721.7 67277.3 68121.7 68847.7 931.4 940.5 953.8 963.9 968.5 14265.4 14412.7 14607.9 14731.0 14808.1 32719.8 32896.3 33157.3 33194.5 33422.2 40807.2 43941.0 44598.3 44760.0 45465.5 7397.2 7424.3 7515.0 7524.7 7606.7 8537.3 11511.0 11779.4 11846.3 12061.9 10360.7 10374.0 10413.2 10500.2 10605.2 9503.6 10395.2 10422.0 10431.9 10667.3 10510.4 10541.6 10602.7 10659.9 10680.5 7453.0 7467.0 7544.7 7604.2 7725.0 8779.3 10395.8 10528.0 10593.4 10647.6 16:12:03 INFO - PROCESS | 16075 | 16:12:03 INFO - PROCESS | 16075 | [#3] mootools.html Cycles:180 Average:5045.41 Median:6043.50 stddev:2601.99 (43.1%) stddev-sans-first:2593.73 16:12:03 INFO - PROCESS | 16075 | Values: 1259.4 1362.8 1366.0 1449.8 1662.4 6980.7 7134.1 7138.9 7157.4 7161.2 7020.9 7179.6 7183.9 7195.2 7202.3 1855.8 2131.9 2164.1 2178.2 2196.3 2181.3 2183.1 2190.9 2194.1 2194.5 2079.2 2163.0 2163.0 2164.4 2169.2 2094.1 2095.5 2106.2 2175.3 2179.2 2118.8 2132.8 2140.5 2141.5 2143.3 7267.2 7321.6 7333.5 7344.4 7349.1 4394.6 4533.4 4564.2 4570.2 4585.2 2911.2 2947.8 3001.2 3014.7 3023.1 956.3 958.9 968.7 992.0 996.4 10012.3 10014.0 10031.5 10032.9 10062.5 4026.4 4161.7 4165.8 4184.8 4230.4 8456.4 8472.9 8482.8 8486.4 8497.5 3850.1 4569.2 4575.2 4605.1 4606.6 3971.3 3991.5 4004.3 4005.3 4010.5 3464.7 3486.4 3514.0 3560.4 3562.6 1129.6 1132.6 1138.6 1141.1 1141.7 1118.0 1119.1 1135.8 1157.8 1200.3 6783.7 6935.5 6941.5 6988.4 7001.0 454.6 462.8 464.8 467.5 467.9 5135.3 5154.4 5188.5 5204.4 5206.1 7895.7 7996.9 8529.1 8830.2 8875.8 7905.9 7949.0 7960.5 7960.8 8037.4 6405.1 6434.8 6494.4 6551.4 6560.0 6749.5 6846.9 6859.0 6864.4 6873.1 7739.3 7863.7 7990.4 8015.6 8103.9 8120.0 8121.0 8300.8 8301.5 8302.6 5597.9 5660.7 5729.4 6603.1 6727.5 6032.3 6468.8 6468.9 6973.6 6975.5 6259.3 6269.7 6360.8 6430.9 6456.7 6245.6 6249.1 6312.6 6335.1 6346.3 6402.4 6527.4 6531.0 6672.7 6690.3 6024.2 6054.7 6058.7 6070.4 6071.5 6005.9 6126.1 6173.3 6208.4 6223.7 16:12:03 INFO - PROCESS | 16075 | 16:12:03 INFO - PROCESS | 16075 | [#4] prototype.html Cycles:180 Average:4771.86 Median:5398.74 stddev:1378.20 (25.5%) stddev-sans-first:1340.94 16:12:03 INFO - PROCESS | 16075 | Values: 319.5 323.2 323.9 328.8 330.2 5434.9 5447.6 5481.8 5486.3 5541.6 5464.9 5471.9 5473.6 5474.9 5481.6 4074.8 4167.9 4242.8 4251.4 4260.3 4257.3 4272.6 4274.3 4294.6 4303.5 4068.5 4270.1 4270.2 4275.2 4279.8 4130.6 4260.9 4271.6 4271.8 4278.7 3767.6 3769.2 3775.6 3783.5 3788.2 5267.5 5269.3 5269.7 5273.2 5278.4 4919.4 4931.7 4934.0 4937.6 4939.0 5738.5 5750.8 5752.8 5762.6 5764.9 3997.6 4145.9 4163.2 4164.5 4169.2 5973.2 6025.5 6031.0 6060.6 6068.9 4225.1 4244.8 4252.9 4254.3 4255.7 4318.8 4321.4 4322.0 4323.4 4326.0 4896.4 4907.5 4912.6 4914.1 4916.1 5768.4 5771.0 5776.8 5783.2 5788.2 1490.4 1513.5 1527.3 1533.1 1533.9 966.4 1019.3 1019.4 1025.0 1037.2 4942.6 4967.2 4990.8 4999.3 5000.8 5935.0 5953.9 5956.8 5964.2 5965.2 4970.0 4983.6 4984.7 4989.8 5001.3 3156.2 3188.2 3192.8 3193.5 3199.2 5331.5 5495.9 5499.8 5511.2 5514.0 6001.1 6005.9 6013.6 6014.0 6029.1 5489.5 5490.0 5509.6 5510.5 5511.4 5893.1 5897.8 5899.1 5904.2 5906.2 5716.9 5759.3 5773.3 5774.6 5775.4 5362.5 5492.2 5494.2 5496.8 5504.1 4096.4 4097.6 4125.4 4130.8 4137.2 5974.7 5981.5 5981.8 5992.7 5993.6 5739.3 5748.8 5750.7 5751.6 5751.8 5745.4 5746.9 5749.9 5752.4 5754.3 5470.2 5570.4 5664.3 5666.9 5680.8 5730.7 5733.9 5738.5 5741.8 5828.2 5670.3 5672.0 5689.0 5691.2 5692.7 16:12:03 INFO - PROCESS | 16075 | 16:12:03 INFO - PROCESS | 16075 | [#5] yui.html Cycles:180 Average:12368.37 Median:23719.42 stddev:13560.85 (57.2%) stddev-sans-first:13570.54 16:12:03 INFO - PROCESS | 16075 | Values: 692.8 723.1 727.0 745.8 763.4 13611.8 13798.4 13832.8 13849.9 13852.1 13432.3 13487.7 13757.2 13971.1 14020.1 640.2 805.3 807.6 823.7 825.1 824.2 827.6 827.9 827.9 828.4 850.5 859.2 860.4 861.3 862.4 663.4 836.1 847.9 850.8 854.1 627.1 627.8 628.0 628.6 629.5 12810.6 12856.9 12882.5 12893.2 12893.3 11748.5 11758.7 12036.9 12337.5 12453.8 9781.6 9886.3 10060.6 10072.1 10293.7 4106.6 4132.4 4172.3 4201.3 4329.3 39729.4 40163.4 40180.8 40233.4 40241.6 9572.4 9597.2 9769.8 9789.2 9955.5 16453.0 16474.3 16498.8 16676.7 16832.2 6923.9 6933.0 6952.7 7003.9 7022.6 3721.7 3731.8 3815.2 3877.3 3926.6 2777.4 2813.1 2817.8 2826.9 2830.0 511.8 512.7 512.8 513.4 528.2 614.3 619.4 636.2 646.0 653.9 7911.1 7982.9 8391.6 8492.7 8531.0 624.2 624.4 627.8 635.4 642.7 3342.6 3415.9 3421.8 3479.2 3492.7 46757.8 47231.5 49647.5 49936.8 49978.0 43237.6 43589.8 43742.0 44092.1 44141.0 39064.6 39401.8 39432.0 39679.0 39822.4 6063.8 6185.2 6613.8 6653.0 6695.3 29661.9 29698.0 30079.0 30969.4 30997.5 38998.0 39487.6 40451.8 40458.8 40544.8 9711.9 10142.8 10299.0 10623.2 10705.8 10954.7 11023.7 11201.0 11233.7 11288.6 10583.7 10725.6 10763.1 10857.6 11168.7 10323.5 10531.7 10570.6 10839.2 10896.5 10617.3 10639.0 10782.8 10848.3 10928.5 8781.4 9008.9 9162.2 9173.6 9206.2 8428.6 8937.4 8963.3 9434.9 9633.2 16:12:03 INFO - PROCESS | 16075 | -------- Summary: end -------- 16:12:03 INFO - PROCESS | 16075 | 16:12:04 INFO - TEST-INFO | 16075: exit 0 16:12:04 INFO - TEST-OK | dromaeo_css | took 1117609ms 16:12:04 INFO - TEST-START | kraken 16:12:04 INFO - operating with platform_type : linux_ 16:12:04 INFO - Initialising browser for kraken test... 16:12:04 INFO - TEST-INFO | started process 16253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDncZ7D/profile http://localhost:46975/getInfo.html) 16:12:08 INFO - PROCESS | 16253 | __metrics Screen width/height:1600/1200 16:12:08 INFO - PROCESS | 16253 | colorDepth:24 16:12:08 INFO - PROCESS | 16253 | Browser inner width/height: 1024/697 16:12:08 INFO - PROCESS | 16253 | __metrics 16:12:09 ERROR - PROCESS | 16253 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:12:09 INFO - TEST-INFO | 16253: exit 0 16:12:09 INFO - Browser initialized. 16:12:09 INFO - Running cycle 1/1 for kraken test... 16:12:09 INFO - TEST-INFO | started process 16335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDncZ7D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:21 INFO - PROCESS | 16335 | RSS: Main: 154357760 16:12:21 INFO - PROCESS | 16335 | 16:12:24 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46975/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:25 INFO - PROCESS | 16335 | RSS: Main: 195096576 16:12:25 INFO - PROCESS | 16335 | 16:12:27 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46975/tests/kraken/driver.html?testName=audio-dft) 16:12:28 INFO - PROCESS | 16335 | RSS: Main: 185364480 16:12:28 INFO - PROCESS | 16335 | 16:12:31 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46975/tests/kraken/driver.html?testName=audio-fft) 16:12:32 INFO - PROCESS | 16335 | RSS: Main: 170733568 16:12:32 INFO - PROCESS | 16335 | 16:12:34 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46975/tests/kraken/driver.html?testName=audio-oscillator) 16:12:34 INFO - PROCESS | 16335 | RSS: Main: 172085248 16:12:34 INFO - PROCESS | 16335 | 16:12:36 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46975/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:37 INFO - PROCESS | 16335 | RSS: Main: 173436928 16:12:37 INFO - PROCESS | 16335 | 16:12:40 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46975/tests/kraken/driver.html?testName=imaging-darkroom) 16:12:41 INFO - PROCESS | 16335 | RSS: Main: 173944832 16:12:41 INFO - PROCESS | 16335 | 16:12:44 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46975/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:45 INFO - PROCESS | 16335 | RSS: Main: 175042560 16:12:45 INFO - PROCESS | 16335 | 16:12:47 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46975/tests/kraken/driver.html?testName=json-parse-financial) 16:12:48 INFO - PROCESS | 16335 | RSS: Main: 175136768 16:12:48 INFO - PROCESS | 16335 | 16:12:50 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46975/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:50 INFO - PROCESS | 16335 | RSS: Main: 183463936 16:12:50 INFO - PROCESS | 16335 | 16:12:52 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46975/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:53 INFO - PROCESS | 16335 | RSS: Main: 183025664 16:12:53 INFO - PROCESS | 16335 | 16:12:55 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46975/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:56 INFO - PROCESS | 16335 | RSS: Main: 196739072 16:12:56 INFO - PROCESS | 16335 | 16:12:58 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:59 INFO - PROCESS | 16335 | RSS: Main: 201146368 16:12:59 INFO - PROCESS | 16335 | 16:13:01 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:02 INFO - PROCESS | 16335 | RSS: Main: 201150464 16:13:02 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | Cycle 1(1): loaded http://localhost:46975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46975/tests/kraken/driver.html?testName=ai-astar) 16:13:04 INFO - PROCESS | 16335 | RSS: Main: 262656000 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | __start_tp_report 16:13:04 INFO - PROCESS | 16335 | _x_x_mozilla_page_load 16:13:04 INFO - PROCESS | 16335 | _x_x_mozilla_page_load_details 16:13:04 INFO - PROCESS | 16335 | |i|pagename|runs| 16:13:04 INFO - PROCESS | 16335 | |0;ai-astar;111;115;109;113;114;112;102;113;112;113 16:13:04 INFO - PROCESS | 16335 | |1;audio-beat-detection;163;136;155;181;136;163;155;132;177;132 16:13:04 INFO - PROCESS | 16335 | |2;audio-dft;161;162;162;159;161;160;162;164;162;161 16:13:04 INFO - PROCESS | 16335 | |3;audio-fft;74;74;107;101;75;75;73;110;97;73 16:13:04 INFO - PROCESS | 16335 | |4;audio-oscillator;95;94;141;95;95;95;140;95;94;141 16:13:04 INFO - PROCESS | 16335 | |5;imaging-gaussian-blur;116;117;116;117;116;116;117;116;117;117 16:13:04 INFO - PROCESS | 16335 | |6;imaging-darkroom;146;146;145;145;145;146;151;145;145;146 16:13:04 INFO - PROCESS | 16335 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 16:13:04 INFO - PROCESS | 16335 | |8;json-parse-financial;66;64;67;66;67;66;65;74;63;63 16:13:04 INFO - PROCESS | 16335 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;64;65;64 16:13:04 INFO - PROCESS | 16335 | |10;stanford-crypto-aes;89;84;83;86;92;82;83;82;91;83 16:13:04 INFO - PROCESS | 16335 | |11;stanford-crypto-ccm;117;122;122;116;123;115;117;134;126;117 16:13:04 INFO - PROCESS | 16335 | |12;stanford-crypto-pbkdf2;141;131;141;145;157;129;147;138;153;141 16:13:04 INFO - PROCESS | 16335 | |13;stanford-crypto-sha256-iterative;69;67;67;67;69;66;67;69;68;72 16:13:04 INFO - PROCESS | 16335 | __end_tp_report 16:13:04 INFO - PROCESS | 16335 | __start_cc_report 16:13:04 INFO - PROCESS | 16335 | _x_x_mozilla_cycle_collect,1181 16:13:04 INFO - PROCESS | 16335 | __end_cc_report 16:13:04 INFO - PROCESS | 16335 | __startTimestamp1459897984316__endTimestamp 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | ------- Summary: start ------- 16:13:04 INFO - PROCESS | 16335 | Number of tests: 14 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.69 (3.3%) stddev-sans-first:3.91 16:13:04 INFO - PROCESS | 16335 | Values: 111.0 115.0 109.0 113.0 114.0 112.0 102.0 113.0 112.0 113.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:159.00 stddev:18.34 (11.5%) stddev-sans-first:19.09 16:13:04 INFO - PROCESS | 16335 | Values: 163.0 136.0 155.0 181.0 136.0 163.0 155.0 132.0 177.0 132.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 16:13:04 INFO - PROCESS | 16335 | Values: 161.0 162.0 162.0 159.0 161.0 160.0 162.0 164.0 162.0 161.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#3] audio-fft Cycles:10 Average:85.90 Median:74.00 stddev:15.74 (21.3%) stddev-sans-first:16.10 16:13:04 INFO - PROCESS | 16335 | Values: 74.0 74.0 107.0 101.0 75.0 75.0 73.0 110.0 97.0 73.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:95.00 stddev:22.20 (23.4%) stddev-sans-first:23.01 16:13:04 INFO - PROCESS | 16335 | Values: 95.0 94.0 141.0 95.0 95.0 95.0 140.0 95.0 94.0 141.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:13:04 INFO - PROCESS | 16335 | Values: 116.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:1.83 (1.3%) stddev-sans-first:1.94 16:13:04 INFO - PROCESS | 16335 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 151.0 145.0 145.0 146.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:13:04 INFO - PROCESS | 16335 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:3.14 (4.8%) stddev-sans-first:3.33 16:13:04 INFO - PROCESS | 16335 | Values: 66.0 64.0 67.0 66.0 67.0 66.0 65.0 74.0 63.0 63.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 16:13:04 INFO - PROCESS | 16335 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 65.0 64.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:3.81 (4.5%) stddev-sans-first:3.82 16:13:04 INFO - PROCESS | 16335 | Values: 89.0 84.0 83.0 86.0 92.0 82.0 83.0 82.0 91.0 83.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:122.00 stddev:5.86 (4.8%) stddev-sans-first:6.04 16:13:04 INFO - PROCESS | 16335 | Values: 117.0 122.0 122.0 116.0 123.0 115.0 117.0 134.0 126.0 117.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:143.00 stddev:8.74 (6.1%) stddev-sans-first:9.26 16:13:04 INFO - PROCESS | 16335 | Values: 141.0 131.0 141.0 145.0 157.0 129.0 147.0 138.0 153.0 141.0 16:13:04 INFO - PROCESS | 16335 | 16:13:04 INFO - PROCESS | 16335 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.73 (2.5%) stddev-sans-first:1.80 16:13:04 INFO - PROCESS | 16335 | Values: 69.0 67.0 67.0 67.0 69.0 66.0 67.0 69.0 68.0 72.0 16:13:04 INFO - PROCESS | 16335 | -------- Summary: end -------- 16:13:04 INFO - PROCESS | 16335 | 16:13:05 INFO - TEST-INFO | 16335: exit 0 16:13:05 INFO - TEST-OK | kraken | took 61139ms 16:13:05 INFO - SUITE-END | took 1178s 16:13:05 INFO - Completed test suite (00:19:39) 16:13:05 INFO - javascript benchmark 16:13:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2592.0539003263807, 2663.5072511585345, 2669.5728683410634, 2677.692065412477, 2690.878910449029, 4539.9773001134945, 4616.676832621718, 4707.058588282344, 4710.717356958585, 4718.858434246974, 4650.534946505348, 4651.883702907429, 4712.0811441768865, 4719.292106184074, 4735.266033764763, 4300.096979634272, 4312.762798046107, 4326.913461730764, 4354.782260886959, 4461.955380446203, 4377.562243775629, 4423.867283981485, 4441.866743997685, 4447.777611119447, 4448.377227188196, 4245.830166793325, 4251.44731184944, 4311.525732169459, 4324.978375108136, 4338.1540599583095, 4266.189424009459, 4268.146370725836, 4286.057067445157, 4317.870463886088, 4326.545712700184, 4248.745075295492, 4253.893652658678, 4255.8084886180195, 4292.227399068166, 4298.570142985708, 4501.0, 4509.661775366828, 4544.068465964469, 4566.337881007268, 4609.124266389375, 4941.629377796679, 4949.232868905326, 4958.057968985881, 4978.079055374767, 4983.127952608279, 4975.601951843843, 4987.476314986947, 4989.550940415344, 4996.675216110941, 5036.949630503721, 4548.408706868086, 4578.313253012008, 4619.1685496610935, 4646.744429056401, 4699.624030077552, 5127.384713834289, 5127.66670166438, 5147.3051138096625, 5149.176131818891, 5173.9999999999245, 4920.360353154067, 4920.5571498565305, 4925.507449255046, 4927.187014142698, 4957.132501812169, 4846.80612775492, 4954.232094025432, 4995.100881841231, 5030.446650868402, 5039.622028347889, 4943.826966056171, 4946.109700253989, 4961.42943561495, 4961.5286547777905, 5011.3986321640905, 4962.057209130326, 4962.8833512459405, 4963.808685915426, 4966.826161084345, 5006.0, 4225.9788701056295, 4283.485981682218, 4286.249906266391, 4286.5284818669925, 4288.0, 3690.9815450922574, 3734.6638802507905, 3752.5684546277525, 3753.230587729509, 3776.4335349697767, 4250.681198910094, 4301.225779359683, 4351.36905148758, 4352.912941741148, 4363.672724545609, 5031.320771695848, 5038.420581633086, 5039.622028347889, 5048.0913435581215, 5063.8480845574695, 4252.681048921281, 4273.995611031405, 4337.9132417351475, 4340.066885619607, 4370.060437006059, 4519.0, 4526.683132180716, 4532.456105267323, 4564.2012647786505, 4581.015081757439, 4685.8594242172785, 4688.390509233915, 4702.835400760957, 4704.858854234379, 4758.04839032188, 4920.163572192808, 4948.950510494849, 4960.181570040902, 4964.429090654621, 5032.471590482946, 4702.365180700562, 4720.103180395714, 4723.338732577373, 4744.169770290255, 4763.214069678603, 4895.975520122377, 4898.363212782316, 4900.191468407816, 4904.166291730486, 4946.0, 4821.4696383397095, 4968.453470118357, 4995.125852975642, 5059.848204553869, 5081.4918508148885, 4771.260454629538, 4777.378940737682, 4788.856334309976, 4791.976040119777, 4836.516348365135, 4793.616510679207, 4803.759812009315, 4807.855764327076, 4811.133995880775, 4856.757162141808, 4647.65142614312, 4728.007118505152, 4748.0, 4771.165046116985, 4812.494688057844, 4818.807247710052, 4820.9517904820505, 4827.227643577011, 4849.224124140121, 4888.2178851383605, 4703.435587729495, 4725.385699858996, 4755.548222918817, 4758.928616070692, 4791.976040119777], "unit": "score", "name": "dojo.html", "value": 4584.657532251198}, {"lowerIsBetter": false, "replicates": [523.1237676891207, 524.6930545630805, 525.0575217484615, 531.6836482293035, 545.0189658614493, 26981.055663051797, 27494.587581186297, 34587.82706086469, 35333.0, 35532.11169720758, 38030.809845950804, 38590.8070459648, 38599.42100868489, 38615.80692096543, 38626.61373386265, 7718.035245594287, 7913.248241417056, 7917.208279172094, 7917.920820791776, 7920.524768513878, 7750.612469376509, 7838.412119091063, 7863.882041769378, 7876.212378762135, 7882.408819338544, 8046.5976701165, 8124.512529248234, 8132.634031468599, 8151.021877374694, 8154.836903261931, 8022.438429309951, 8085.474444161169, 8104.189581041907, 8104.311133553655, 8104.6352914118415, 7939.404544659116, 8044.517328960281, 8074.232947870002, 8078.838423231502, 8084.757457276232, 38850.0, 38975.610243897485, 39014.804925975186, 39219.803900980594, 39302.410463843065, 3227.467467867799, 3242.319112986252, 3284.1953721338423, 3534.6642069003406, 3890.688744900401, 29405.85297073501, 29421.264468388246, 29694.851525742448, 29793.25516862074, 29867.0, 3465.8440370183403, 3518.0, 3518.982405087984, 3599.7660152090293, 3602.225521512887, 184213.0, 185233.0, 185263.0, 185267.07366463082, 186079.0, 44084.559154408686, 44644.330335045, 44666.0, 55874.0, 57433.425665742805, 40584.59415405867, 40650.59349406527, 40750.59249407468, 40875.7956210223, 40918.0, 15021.924890375478, 15153.54539363821, 15180.316885740169, 15186.240687965557, 15188.924055379874, 11268.661940141645, 11284.887151128547, 11300.20898537111, 11303.03924166455, 11305.208635395607, 15143.469978550698, 15156.772648410282, 15175.772363414557, 15204.695906081817, 15327.31027103783, 5522.337319521683, 5624.634398764068, 5699.2590963174525, 5774.881563955417, 5853.0635098384055, 875.8335916175906, 883.3639779358851, 1017.3590637898225, 1025.1418013489729, 1044.3785947361307, 26971.325716857235, 27104.32239194036, 27182.45635087287, 27269.863650682015, 27513.72486275152, 969.9175570076623, 996.6511720897628, 1026.5329275179774, 1052.1898138433517, 1059.131512160037, 14094.436222550983, 14484.927575362055, 14565.344559494848, 14893.77659335111, 14925.925370373296, 292021.0, 294974.0, 295708.0, 295871.0, 295878.0, 47686.28470572944, 48637.513624864005, 48722.0, 48745.75627121913, 48764.26853597199, 1108.9611863584735, 1218.469965564982, 1251.8122281657825, 1253.4798058805493, 1309.2210134969678, 24417.0, 25378.492430151662, 25709.35726606775, 25782.742172578033, 25828.225153245432, 38635.420468693555, 38993.80503097466, 39247.80376098101, 39320.0, 39367.606323937536, 203046.0, 203254.0, 203518.0, 203590.0, 203796.0, 26805.195844124708, 31461.0, 31527.84236078805, 31682.0, 32241.51637725389, 36398.27203455863, 36507.81746091359, 37161.256774864894, 37438.251234975694, 37507.2498550022, 33216.335673286885, 33218.50172247466, 33622.327553449286, 33773.3245335087, 34818.12954676052, 33113.66886331106, 33512.83243583766, 33700.15749606279, 34063.65936340605, 34235.828820855735, 34000.82999585085, 34030.0, 34308.14229644279, 34633.0, 37418.625813742605, 26979.460410792068, 30585.23536911506, 30798.69201307958, 30811.691883081778, 31124.68875311218, 24444.14445494399, 24893.377665558506, 25284.620730688686, 25600.231993040237, 26114.477710446066], "unit": "score", "name": "ext.html", "value": 16575.395577419156}, {"lowerIsBetter": false, "replicates": [327.17388593800644, 331.7047827433584, 344.10704222542495, 354.5444104325942, 357.412057165962, 15094.62263443413, 15562.45531406401, 16129.0, 16872.409465668705, 16886.74669879953, 16275.83724162758, 16309.673806523862, 16716.331346746145, 17087.145642717845, 17157.313707451718, 4770.379850619414, 4968.006398720252, 4971.105201063807, 4988.4762099979525, 5234.895302093956, 5380.542653874406, 5386.946130538684, 5418.593605479585, 5418.783248670048, 5426.0, 5358.142697168454, 5396.595255355864, 5404.270423492837, 5405.027095122877, 5406.405295417501, 5331.0, 5388.110961691316, 5415.13357862742, 5463.590230732711, 5470.17947307903, 5253.264542963988, 5261.710605916673, 5321.787128514855, 5322.175062865262, 5332.093544097474, 11736.88263117375, 11741.29552226869, 11751.059915206848, 11764.058875289957, 11972.58095966637, 1909.1313452379134, 1947.7175809507685, 1966.3412756726514, 2229.765874583162, 2257.4694946687514, 9222.631094756201, 9333.393329433566, 9580.90419095807, 9838.704838854774, 12947.546835860794, 1756.3764863473539, 1813.3834496271331, 1847.187237615445, 1872.3353209610664, 1928.498590366515, 56391.71804140994, 58050.0, 58336.0, 58589.707051465324, 59040.70479647617, 9677.274204434696, 9772.902270977342, 9833.704988850346, 9894.356866803635, 9941.19028465489, 13343.66640833987, 13346.332683365792, 13396.665083372995, 13436.664083397798, 13471.191728496322, 7349.522281051822, 7429.925700742923, 7449.962750186214, 7559.886601700979, 7571.318581327707, 7132.500724949307, 7166.0, 7244.963775181196, 7295.489315747953, 7321.78034658961, 4236.4704411948505, 4237.173751118564, 4238.198765524639, 4303.655707543389, 4308.289132293136, 1781.518989872753, 1796.5329014456074, 1797.5685835399672, 1806.8554515638718, 1834.3763120539081, 850.6469815026694, 862.5600943518725, 920.6041402196986, 930.9115634014757, 974.6442548469757, 15808.130552819475, 16037.679246415006, 16083.758743618855, 16147.273372698257, 16205.351785928666, 856.9485830850169, 869.7782065573239, 879.4151888993875, 895.1048951048951, 898.793277546168, 8848.159424854628, 9043.276537876955, 9124.17882390588, 9310.301727370474, 9388.0, 370205.0, 374371.0, 377088.0, 378558.0, 380310.0, 63776.36223637797, 66721.66639166774, 67277.32722672711, 68121.65939170272, 68847.65576172087, 931.380631879806, 940.4921342474987, 953.7853982853941, 963.9325247232766, 968.5447839515416, 14265.42938282457, 14412.711745765235, 14607.853921461074, 14731.0, 14808.111513309235, 32719.836400817843, 32896.342073158885, 33157.33685326231, 33194.5020824683, 33422.164445889044, 40807.1838563233, 43941.0, 44598.331025034, 44760.0, 45465.545344547456, 7397.223291554525, 7424.257574242532, 7515.0, 7524.661390237343, 7606.733764318223, 8537.286280468017, 11511.0, 11779.412423863429, 11846.348450834943, 12061.879381206427, 10360.689179324632, 10373.987613149227, 10413.219008574235, 10500.212484063879, 10605.204609654153, 9503.619855205714, 10395.16838652921, 10422.0, 10431.94784026075, 10667.306625069346, 10510.421926794099, 10541.57833686644, 10602.681919542427, 10659.94670026645, 10680.519376627915, 7452.962735186289, 7466.962665186639, 7544.66049027806, 7604.201558836464, 7724.961375193088, 8779.297656187617, 10395.792084158425, 10528.0, 10593.364398136137, 10647.627333043307], "unit": "score", "name": "jquery.html", "value": 7937.738625369287}, {"lowerIsBetter": false, "replicates": [1259.3640211693094, 1362.8023936529203, 1365.9726805463895, 1449.8042764226827, 1662.3516828436912, 6980.7207711691535, 7134.143902731679, 7138.928610713891, 7157.427405807536, 7161.212266650664, 7020.929790702092, 7179.641017949095, 7183.856322873539, 7195.208527062019, 7202.279772022795, 1855.8144185581402, 2131.8827464489445, 2164.0802658869957, 2178.18318130701, 2196.253273886878, 2181.334692918659, 2183.1049269799387, 2190.9014094365793, 2194.078487035449, 2194.5281764420647, 2079.241077006897, 2162.9891850540725, 2163.026638012893, 2164.3615133535645, 2169.208238992764, 2094.0576740466777, 2095.476130967258, 2106.2312256026594, 2175.3147758456034, 2179.24815938501, 2118.8093071623475, 2132.797384248494, 2140.475583482041, 2141.486043349585, 2143.3248526714037, 7267.236940121264, 7321.633918304064, 7333.523320984119, 7344.412447004281, 7349.081364829396, 4394.62645675118, 4533.38799262102, 4564.2240819060835, 4570.177368073745, 4585.243434833248, 2911.213972227508, 2947.7936544441895, 3001.1746769638307, 3014.6834582368756, 3023.1232942446886, 956.2541217850088, 958.9232861371144, 968.6706519783307, 991.9553620087113, 996.3822430093317, 10012.29913906027, 10014.0, 10031.498425078717, 10032.94983525085, 10062.547185376676, 4026.4095682205366, 4161.729487583298, 4165.791710414467, 4184.790760461965, 4230.365445183185, 8456.365772567082, 8472.915270847336, 8482.787930301669, 8486.448380855225, 8497.532635705096, 3850.133719912997, 4569.200389931749, 4575.24508456101, 4605.148047611203, 4606.631469482433, 3971.2653159165648, 3991.481107456012, 4004.279229738675, 4005.2790497710694, 4010.5387880393546, 3464.7401444891734, 3486.38988177068, 3514.0, 3560.394732895414, 3562.59030211529, 1129.6444266879778, 1132.6092498088146, 1138.618562781461, 1141.1270378160714, 1141.680329507739, 1118.0440723181562, 1119.0711709281277, 1135.784201001807, 1157.7742340243572, 1200.255841378351, 6783.694733736895, 6935.514513983972, 6941.548799328028, 6988.371046605728, 7001.0, 454.5590776946357, 462.81024779840106, 464.7745843266013, 467.4810959834581, 467.94384673838675, 5135.2553879687985, 5154.407243167008, 5188.45521220274, 5204.375474943031, 5206.062908676475, 7895.723649672349, 7996.9200307997335, 8529.14708529142, 8830.161134692195, 8875.822483550422, 7905.920940790634, 7949.0, 7960.522368657899, 7960.761177164694, 8037.437379383504, 6405.135306733625, 6434.806955791334, 6494.415502604694, 6551.377619126175, 6560.0, 6749.493787965824, 6846.863062738617, 6859.039734437083, 6864.4165245954655, 6873.072135261676, 7739.3421559165845, 7863.724769633035, 7990.360771138178, 8015.639296231567, 8103.878441823495, 8119.959400203197, 8120.959395202986, 8300.750977470685, 8301.543415112226, 8302.584870756316, 5597.888042239214, 5660.7169641518585, 5729.3984131665575, 6603.075569420381, 6727.461803055841, 6032.328595970577, 6468.773592924225, 6468.870622587616, 6973.6164510952385, 6975.546589471668, 6259.3427690091885, 6269.717862696099, 6360.840978975562, 6430.871382572229, 6456.741730330734, 6245.6252624842655, 6249.0626406039455, 6312.558120931674, 6335.1447554579545, 6346.270178929482, 6402.423781859655, 6527.445167160845, 6531.0, 6672.733090676513, 6690.330966903465, 6024.156618073385, 6054.666993315233, 6058.727357269022, 6070.423309785563, 6071.453569178795, 6005.879882402415, 6126.050462178369, 6173.259208894961, 6208.410201030895, 6223.657698826608], "unit": "score", "name": "mootools.html", "value": 4099.403538806816}, {"lowerIsBetter": false, "replicates": [319.4680856374137, 323.19363188843835, 323.90606724050036, 328.78957467220965, 330.2173847980287, 5434.945650543494, 5447.645903016301, 5481.75332110055, 5486.259354987075, 5541.556675465963, 5464.890702185954, 5471.917921231185, 5473.644213126154, 5474.91787623185, 5481.588880833933, 4074.8166332515034, 4167.874963751077, 4242.809073591696, 4251.362295655661, 4260.339647354649, 4257.297545904922, 4272.572742725733, 4274.252005898955, 4294.570542945712, 4303.462067241595, 4068.5117785865737, 4270.12462445198, 4270.210011147948, 4275.166342563201, 4279.7860106994685, 4130.607592278729, 4260.9147817043795, 4271.551487093841, 4271.765052922088, 4278.700490965633, 3767.6232376762377, 3769.189624230776, 3775.5846856845724, 3783.4703141560203, 3788.1855401088897, 5267.525922666979, 5269.262303277545, 5269.736513174326, 5273.156294992821, 5278.419373868871, 4919.3604831371695, 4931.65478416511, 4933.950660493385, 4937.604991600663, 4938.950610493885, 5738.512226460756, 5750.79872204475, 5752.769889204426, 5762.625429347079, 5764.913526297109, 3997.560268370477, 4145.937810932838, 4163.167366526707, 4164.479440069991, 4169.1661667666585, 5973.223480947492, 6025.487833534155, 6031.0048841941025, 6060.606060606091, 6068.939310606882, 4225.112726327444, 4244.808983595745, 4252.872413827528, 4254.276772948606, 4255.659547236276, 4318.848840290638, 4321.438213032286, 4322.0, 4323.437953066082, 4326.026644005074, 4896.436909755424, 4907.509249075135, 4912.631552633567, 4914.140025495524, 4916.0905232532095, 5768.394318596571, 5771.0477771168125, 5776.797812076557, 5783.248177736868, 5788.18965344852, 1490.3665941974834, 1513.523240179362, 1527.3203424476224, 1533.0954736705398, 1533.8879312498573, 966.3573723473811, 1019.261035749076, 1019.3985548526405, 1024.9743756406149, 1037.1754455208127, 4942.629302802232, 4967.155583550805, 4990.750462476862, 4999.275105109738, 5000.824971126066, 5935.0, 5953.851153721192, 5956.791512297049, 5964.224650795369, 5965.194698715704, 4970.0, 4983.551480366785, 4984.7258400788305, 4989.80040798364, 5001.274815151783, 3156.179393357698, 3188.218886372807, 3192.776505644629, 3193.473076942325, 3199.232184275757, 5331.546818520469, 5495.917561236584, 5499.835004949858, 5511.200875873056, 5513.972430137824, 6001.099835024781, 6005.939940600538, 6013.639181649115, 6014.0, 6029.125776762345, 5489.451054894478, 5490.0, 5509.641873278224, 5510.504054635022, 5511.4213007633625, 5893.057110862242, 5897.7935772247765, 5899.144624029577, 5904.173415721888, 5906.202662640489, 5716.9142462862255, 5759.337676167294, 5773.3072031356505, 5774.595778295479, 5775.422457754191, 5362.5441837442695, 5492.176173573996, 5494.1758736189895, 5496.80761173357, 5504.146857237135, 4096.365063415175, 4097.631213190827, 4125.401816736617, 4130.752154870717, 4137.151883863861, 5974.6713930732485, 5981.461668449861, 5981.820545383645, 5992.700364981646, 5993.550483713651, 5739.339975902824, 5748.798792042258, 5750.6837123958585, 5751.568632352507, 5751.798687046101, 5745.425457454221, 5746.856328591652, 5749.885002300014, 5752.424757524214, 5754.309482862083, 5470.206820011155, 5570.4151064139305, 5664.320281566073, 5666.886662266649, 5680.801171958961, 5730.684812335361, 5733.885322293448, 5738.540916726735, 5741.827745167651, 5828.242328497268, 5670.319561652628, 5672.035753921926, 5689.0, 5691.231683722644, 5692.658440493584], "unit": "score", "name": "prototype.html", "value": 4333.455675917465}, {"lowerIsBetter": false, "replicates": [692.8406466512699, 723.1286300008487, 726.9927300726991, 745.7986343687203, 763.4236151705462, 13611.795823062663, 13798.448062077505, 13832.792508112374, 13849.930750346233, 13852.099613525113, 13432.32838358083, 13487.730245395087, 13757.243351615682, 13971.091879027856, 14020.088694234868, 640.1837656987332, 805.2752522729531, 807.6405999330315, 823.6787652815377, 825.1294883897485, 824.2293455619016, 827.5944787054331, 827.8634025385804, 827.9296259817893, 828.4449418889359, 850.5024560632007, 859.2095272349422, 860.3805260212637, 861.3109512390095, 862.4006315610621, 663.3731124087739, 836.1471299274706, 847.8728190771373, 850.808568072185, 854.0520022774715, 627.137685682187, 627.8053803320939, 628.0171531553104, 628.5914155798722, 629.468099455959, 12810.551630692975, 12856.935715321457, 12882.484700611963, 12893.161944473579, 12893.290869002201, 11748.471318790675, 11758.706032349173, 12036.939815300955, 12337.50649974009, 12453.813192802116, 9781.559829807677, 9886.258530610234, 10060.647877324333, 10072.143867771249, 10293.691189264335, 4106.609872062149, 4132.380142978547, 4172.290710579209, 4201.264778663753, 4329.307310830283, 39729.40405893914, 40163.39754903679, 40180.79909600433, 40233.39649905283, 40241.59758402437, 9572.377795443273, 9597.184239339595, 9769.804603907882, 9789.167920726817, 9955.50222488887, 16453.0, 16474.258658360402, 16498.75251871223, 16676.74984875228, 16832.158392080346, 6923.930760692429, 6933.0293758873795, 6952.7218911244, 7003.8599228015155, 7022.613756243353, 3721.702263818888, 3731.7574357666663, 3815.198808250243, 3877.3214687429586, 3926.6466018058513, 2777.416742484101, 2813.099808061401, 2817.7604903583424, 2826.943461130766, 2829.9812067655625, 511.8464460661861, 512.674451723151, 512.7923191107608, 513.4147072337538, 528.2050513976518, 614.2506142506224, 619.4270299972508, 636.2333388267127, 645.9935400646027, 653.8921078022073, 7911.129775724666, 7982.920170798334, 8391.622297455177, 8492.74521764348, 8531.0, 624.1698540940538, 624.3787431505681, 627.8273474794377, 635.4249404289126, 642.6915080761261, 3342.5821772278464, 3415.9146021349666, 3421.794692318419, 3479.1650003999366, 3492.7205823534564, 46757.766211168724, 47231.527684722714, 49647.50352496501, 49936.750316248916, 49978.0, 43237.56762432399, 43589.78205109017, 43742.0, 44092.118157636665, 44141.0, 39064.609353906664, 39401.80299098486, 39432.0, 39679.00802480019, 39822.40266396006, 6063.848403789941, 6185.195924529782, 6613.768518101843, 6652.966735166293, 6695.330466953265, 29661.85169074141, 29698.0, 30079.0, 30969.380612388075, 30997.535036974914, 38998.0, 39487.60512394839, 40451.797741011105, 40458.79770601128, 40544.79727601343, 9711.902880971382, 10142.847174457136, 10299.0, 10623.203259755395, 10705.839412408664, 10954.698725979211, 11023.724406889893, 11201.0, 11233.66299011031, 11288.604898828502, 10583.735406614896, 10725.624603138853, 10763.085137763377, 10857.565697372016, 11168.66494005181, 10323.535440905027, 10531.736706582396, 10570.630027948984, 10839.187060970302, 10896.509657065293, 10617.29130076694, 10638.977316953831, 10782.838257426301, 10848.349099054081, 10928.453577320943, 8781.429207101519, 9008.86486702713, 9162.175404213385, 9173.633054677739, 9206.17144457002, 8428.585627671157, 8937.374383793072, 8963.282937364866, 9434.858477122985, 9633.217854696904], "unit": "score", "name": "yui.html", "value": 5898.563093551037}], "name": "dromaeo_css", "value": 6311.538499459842}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 109.0, 113.0, 114.0, 112.0, 102.0, 113.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [163.0, 136.0, 155.0, 181.0, 136.0, 163.0, 155.0, 132.0, 177.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 153.0}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 159.0, 161.0, 160.0, 162.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 107.0, 101.0, 75.0, 75.0, 73.0, 110.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.9}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 141.0, 95.0, 95.0, 95.0, 140.0, 95.0, 94.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 151.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 67.0, 66.0, 67.0, 66.0, 65.0, 74.0, 63.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 66.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [89.0, 84.0, 83.0, 86.0, 92.0, 82.0, 83.0, 82.0, 91.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [117.0, 122.0, 122.0, 116.0, 123.0, 115.0, 117.0, 134.0, 126.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [141.0, 131.0, 141.0, 145.0, 157.0, 129.0, 147.0, 138.0, 153.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 67.0, 69.0, 66.0, 67.0, 69.0, 68.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1524.8999999999999}]} 16:13:05 INFO - Return code: 0 16:13:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:13:05 ERROR - # TBPL SUCCESS # 16:13:05 INFO - Running post-action listener: _resource_record_post_action 16:13:05 INFO - Running post-run listener: _resource_record_post_run 16:13:06 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 519790592; Read time: 0; Write time: 474832 16:13:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233279488; Read time: 0; Write time: 260932 16:13:06 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 286511104; Read time: 0; Write time: 213900 16:13:06 INFO - Running post-run listener: _upload_blobber_files 16:13:06 INFO - Blob upload gear active. 16:13:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:13:07 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:13:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:07 INFO - (blobuploader) - INFO - Done attempting. 16:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:08 INFO - (blobuploader) - INFO - Done attempting. 16:13:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:08 INFO - Return code: 0 16:13:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/748f1cee9dd18e6975a20a4f6fd03a3b50b72daae47453287c786b82146993a1cb6032fac1e0a5e2086db9601975f54ba5db46c0e7b7d40a5a750a825bc3fa79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d7d3db0af294ad445df6d24a0830127182de1c5e89d2f42b9a43687904cdc3a0b077f6f19aa9d9d8aeb83c2e47e28ed79be2b80a5d31783b03c0f3ab6259ad2"} 16:13:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:08 INFO - Contents: 16:13:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/748f1cee9dd18e6975a20a4f6fd03a3b50b72daae47453287c786b82146993a1cb6032fac1e0a5e2086db9601975f54ba5db46c0e7b7d40a5a750a825bc3fa79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d7d3db0af294ad445df6d24a0830127182de1c5e89d2f42b9a43687904cdc3a0b077f6f19aa9d9d8aeb83c2e47e28ed79be2b80a5d31783b03c0f3ab6259ad2"} 16:13:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:08 INFO - Copying logs to upload dir... 16:13:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.128827 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-05 16:13:08.473519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 16:13:08.477353) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424 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/748f1cee9dd18e6975a20a4f6fd03a3b50b72daae47453287c786b82146993a1cb6032fac1e0a5e2086db9601975f54ba5db46c0e7b7d40a5a750a825bc3fa79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d7d3db0af294ad445df6d24a0830127182de1c5e89d2f42b9a43687904cdc3a0b077f6f19aa9d9d8aeb83c2e47e28ed79be2b80a5d31783b03c0f3ab6259ad2"} build_url:https://queue.taskcluster.net/v1/task/OV7qk28mTrmPSY1IiwmUdg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/OV7qk28mTrmPSY1IiwmUdg/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/748f1cee9dd18e6975a20a4f6fd03a3b50b72daae47453287c786b82146993a1cb6032fac1e0a5e2086db9601975f54ba5db46c0e7b7d40a5a750a825bc3fa79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d7d3db0af294ad445df6d24a0830127182de1c5e89d2f42b9a43687904cdc3a0b077f6f19aa9d9d8aeb83c2e47e28ed79be2b80a5d31783b03c0f3ab6259ad2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 16:13:08.509068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:13:08.509670) ========= 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=652eb03db935cfc1c15ebda0000001ad-1459895408.911214-258371424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 16:13:08.592109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 16:13:08.592465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 16:13:08.592828) ========= ========= Total master_lag: 0.30 =========