builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1459985296.73 results: success (0) buildid: 20160406160854 builduid: 1467794a4825431096c8d01a7866e9ee revision: 133d8859d7b5e7d44d74c66aaa52c2da30cab3c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.733283) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.733916) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.734272) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.766046) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.766374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.808407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.808767) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.873394) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.873710) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.874091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:16.874446) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-06 16:28:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.0M=0.001s 2016-04-06 16:28:17 (23.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:17.044800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:17.045137) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017670 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:17.096016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:17.096421) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 133d8859d7b5e7d44d74c66aaa52c2da30cab3c4 --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 133d8859d7b5e7d44d74c66aaa52c2da30cab3c4 --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=516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-06 16:28:17,401 truncating revision to first 12 chars 2016-04-06 16:28:17,401 Setting DEBUG logging. 2016-04-06 16:28:17,401 attempt 1/10 2016-04-06 16:28:17,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/133d8859d7b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 16:28:17,650 unpacking tar archive at: fx-team-133d8859d7b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.514165 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:17.623600) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:17.623962) ========= echo 133d8859d7b5e7d44d74c66aaa52c2da30cab3c4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'133d8859d7b5e7d44d74c66aaa52c2da30cab3c4'] 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=516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 133d8859d7b5e7d44d74c66aaa52c2da30cab3c4 program finished with exit code 0 elapsedTime=0.004738 script_repo_revision: '133d8859d7b5e7d44d74c66aaa52c2da30cab3c4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:17.674977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:17.675322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 16:28:17.687536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 44 mins, 33 secs) (at 2016-04-06 16:28:17.687855) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:28:18 INFO - MultiFileLogger online at 20160406 16:28:18 in /builds/slave/test 16:28:18 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 16:28:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:28:18 INFO - {'append_to_log': False, 16:28:18 INFO - 'base_work_dir': '/builds/slave/test', 16:28:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:28:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:28:18 INFO - 'branch': 'Fx-Team-Non-PGO', 16:28:18 INFO - 'buildbot_json_path': 'buildprops.json', 16:28:18 INFO - 'config_files': ('talos/linux_config.py',), 16:28:18 INFO - 'default_actions': ('clobber', 16:28:18 INFO - 'read-buildbot-config', 16:28:18 INFO - 'download-and-extract', 16:28:18 INFO - 'populate-webroot', 16:28:18 INFO - 'create-virtualenv', 16:28:18 INFO - 'install', 16:28:18 INFO - 'run-tests'), 16:28:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:28:18 INFO - 'download_minidump_stackwalk': True, 16:28:18 INFO - 'download_symbols': 'ondemand', 16:28:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:28:18 INFO - 'tooltool.py': '/tools/tooltool.py', 16:28:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:28:18 INFO - '/tools/misc-python/virtualenv.py')}, 16:28:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:28:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:28:18 INFO - 'installer_path': 'installer.exe', 16:28:18 INFO - 'log_level': 'info', 16:28:18 INFO - 'log_name': 'talos', 16:28:18 INFO - 'log_to_console': True, 16:28:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:28:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:28:18 INFO - 'opt_config_files': (), 16:28:18 INFO - 'pip_index': False, 16:28:18 INFO - 'sps_profile': False, 16:28:18 INFO - 'sps_profile_interval': 0, 16:28:18 INFO - 'suite': 'dromaeojs', 16:28:18 INFO - 'system_bits': '32', 16:28:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:28:18 INFO - 'title': 'talos-linux64-ix-061', 16:28:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:28:18 INFO - 'use_talos_json': True, 16:28:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:28:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:28:18 INFO - 'work_dir': 'build'} 16:28:18 INFO - ##### 16:28:18 INFO - ##### Running clobber step. 16:28:18 INFO - ##### 16:28:18 INFO - Running pre-action listener: _resource_record_pre_action 16:28:18 INFO - Running main action method: clobber 16:28:18 INFO - rmtree: /builds/slave/test/build 16:28:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:28:18 INFO - Running post-action listener: _resource_record_post_action 16:28:18 INFO - ##### 16:28:18 INFO - ##### Running read-buildbot-config step. 16:28:18 INFO - ##### 16:28:18 INFO - Running pre-action listener: _resource_record_pre_action 16:28:18 INFO - Running main action method: read_buildbot_config 16:28:18 INFO - Using buildbot properties: 16:28:18 INFO - { 16:28:18 INFO - "project": "", 16:28:18 INFO - "product": "firefox", 16:28:18 INFO - "script_repo_revision": "production", 16:28:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:28:18 INFO - "repository": "", 16:28:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:28:18 INFO - "buildid": "20160406160854", 16:28:18 INFO - "pgo_build": "False", 16:28:18 INFO - "basedir": "/builds/slave/test", 16:28:18 INFO - "buildnumber": 1618, 16:28:18 INFO - "slavename": "talos-linux64-ix-061", 16:28:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:28:18 INFO - "platform": "ubuntu64_hw", 16:28:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:28:18 INFO - "branch": "fx-team", 16:28:18 INFO - "repo_path": "integration/fx-team", 16:28:18 INFO - "revision": "133d8859d7b5e7d44d74c66aaa52c2da30cab3c4", 16:28:18 INFO - "stage_platform": "linux64", 16:28:18 INFO - "builduid": "1467794a4825431096c8d01a7866e9ee", 16:28:18 INFO - "slavebuilddir": "test" 16:28:18 INFO - } 16:28:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:28:18 INFO - Running post-action listener: _resource_record_post_action 16:28:18 INFO - ##### 16:28:18 INFO - ##### Running download-and-extract step. 16:28:18 INFO - ##### 16:28:18 INFO - Running pre-action listener: _resource_record_pre_action 16:28:18 INFO - Running main action method: download_and_extract 16:28:18 INFO - mkdir: /builds/slave/test/build/tests 16:28: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')]} 16:28:18 INFO - https://queue.taskcluster.net/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:28:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:28:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:28:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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 16:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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 16:28:25 INFO - Downloaded 1361 bytes. 16:28:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:28:25 INFO - Using the following test package requirements: 16:28:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:28:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:28:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:28:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:25 INFO - u'jsshell-linux-x86_64.zip'], 16:28:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:28:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:28:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:28:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:28:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:28:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:28:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:28: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')]} 16:28:25 INFO - https://queue.taskcluster.net/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:28:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:28:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:28:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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 16:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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 16:32:49 INFO - Downloaded 22136717 bytes. 16:32:49 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'] 16:32:49 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 16:32:50 INFO - Return code: 0 16:32:50 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 16:32: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')]} 16:32:50 INFO - https://queue.taskcluster.net/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:32:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:32:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:32:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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 16:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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 16:32:56 INFO - Downloaded 22136717 bytes. 16:32:56 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'] 16:32:56 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 16:32:57 INFO - Return code: 0 16:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:57 INFO - https://queue.taskcluster.net/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:32:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:32:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:32:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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 16:32:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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 16:32:58 INFO - Downloaded 10847617 bytes. 16:32:58 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'] 16:32:58 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 16:32:59 INFO - Return code: 0 16:32: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')]} 16:32:59 INFO - https://queue.taskcluster.net/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:32:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:32:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:32:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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 16:32:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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 16:52:24 INFO - Downloaded 54185393 bytes. 16:52:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:52:24 INFO - mkdir: /builds/slave/test/properties 16:52:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:52:24 INFO - Writing to file /builds/slave/test/properties/build_url 16:52:24 INFO - Contents: 16:52:24 INFO - build_url:https://queue.taskcluster.net/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:52:26 INFO - Running post-action listener: _resource_record_post_action 16:52:26 INFO - Running post-action listener: set_extra_try_arguments 16:52:26 INFO - ##### 16:52:26 INFO - ##### Running populate-webroot step. 16:52:26 INFO - ##### 16:52:26 INFO - Running pre-action listener: _resource_record_pre_action 16:52:26 INFO - Running main action method: populate_webroot 16:52:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:52:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:52:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:52:26 INFO - '--tppagecycles', 16:52:26 INFO - '7'], 16:52:26 INFO - 'tests': ['tsvgm']}}, 16:52:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:52:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:52:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:52:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:52:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:52:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:52:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:26 INFO - 'talos_options': ['--disable-e10s'], 16:52:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:26 INFO - 'talos_options': ['--disable-e10s'], 16:52:26 INFO - 'tests': ['damp', 'tps']}, 16:52:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:26 INFO - 'tests': ['damp', 'tps']}, 16:52:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:52:26 INFO - 'tests': ['dromaeo_dom']}, 16:52:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:52:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:52:26 INFO - 'tests': ['a11yr', 16:52:26 INFO - 'ts_paint', 16:52:26 INFO - 'tpaint', 16:52:26 INFO - 'sessionrestore', 16:52:26 INFO - 'sessionrestore_no_auto_restore', 16:52:26 INFO - 'tabpaint']}, 16:52:26 INFO - 'other-e10s': {'tests': ['a11yr', 16:52:26 INFO - 'ts_paint', 16:52:26 INFO - 'tpaint', 16:52:26 INFO - 'sessionrestore', 16:52:26 INFO - 'sessionrestore_no_auto_restore', 16:52:26 INFO - 'tabpaint']}, 16:52:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:52:26 INFO - 'ts_paint', 16:52:26 INFO - 'tpaint', 16:52:26 INFO - 'sessionrestore', 16:52:26 INFO - 'sessionrestore_no_auto_restore', 16:52:26 INFO - 'tabpaint']}, 16:52:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:52:26 INFO - 'ts_paint', 16:52:26 INFO - 'tpaint', 16:52:26 INFO - 'sessionrestore', 16:52:26 INFO - 'sessionrestore_no_auto_restore', 16:52:26 INFO - 'tabpaint']}, 16:52:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:52:26 INFO - 'tests': ['a11yr', 16:52:26 INFO - 'ts_paint', 16:52:26 INFO - 'tpaint', 16:52:26 INFO - 'sessionrestore', 16:52:26 INFO - 'sessionrestore_no_auto_restore', 16:52:26 INFO - 'tabpaint']}, 16:52:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:52:26 INFO - 'tests': ['a11yr', 16:52:26 INFO - 'ts_paint', 16:52:26 INFO - 'tpaint', 16:52:26 INFO - 'sessionrestore', 16:52:26 INFO - 'sessionrestore_no_auto_restore', 16:52:26 INFO - 'tabpaint']}, 16:52:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:52:26 INFO - 'tests': ['tsvgx', 16:52:26 INFO - 'tsvgr_opacity', 16:52:26 INFO - 'tart', 16:52:26 INFO - 'tscrollx', 16:52:26 INFO - 'cart']}, 16:52:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:52:26 INFO - 'tsvgr_opacity', 16:52:26 INFO - 'tart', 16:52:26 INFO - 'tscrollx', 16:52:26 INFO - 'cart']}, 16:52:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:26 INFO - 'talos_options': ['--disable-e10s'], 16:52:26 INFO - 'tests': ['tp5o']}, 16:52:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:26 INFO - 'tests': ['tp5o']}, 16:52:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:26 INFO - 'talos_options': ['--disable-e10s', 16:52:26 INFO - '--xperf_path', 16:52:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:26 INFO - 'tests': ['tp5n']}, 16:52:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:26 INFO - 'talos_options': ['--xperf_path', 16:52:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:26 INFO - 'tests': ['tp5n']}}, 16:52:26 INFO - 'talos.zip': {'path': '', 16:52:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:52:26 INFO - Running post-action listener: _resource_record_post_action 16:52:26 INFO - ##### 16:52:26 INFO - ##### Running create-virtualenv step. 16:52:26 INFO - ##### 16:52:26 INFO - Running pre-action listener: _resource_record_pre_action 16:52:26 INFO - Running main action method: create_virtualenv 16:52:26 INFO - Creating virtualenv /builds/slave/test/build/venv 16:52:26 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 16:52:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:52:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:52:26 INFO - Using real prefix '/usr' 16:52:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:52:26 INFO - Installing distribute.............................................................................................................................................................................................done. 16:52:28 INFO - Installing pip.................done. 16:52:28 INFO - Return code: 0 16:52:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:52:28 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')]} 16:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:28 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')]} 16:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:28 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 0x7fabaa739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ad410>, '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 0x23ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', '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 16:52:28 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 16:52:28 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 16:52:28 INFO - Using env: {'DISPLAY': ':0', 16:52:28 INFO - 'HOME': '/home/cltbld', 16:52:28 INFO - 'LANG': 'en_US.UTF-8', 16:52:28 INFO - 'LANGUAGE': 'en_US:en', 16:52:28 INFO - 'LOGNAME': 'cltbld', 16:52:28 INFO - 'MAIL': '/var/mail/cltbld', 16:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:28 INFO - 'MOZ_NO_REMOTE': '1', 16:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:28 INFO - 'NO_EM_RESTART': '1', 16:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:28 INFO - 'PWD': '/builds/slave/test', 16:52:28 INFO - 'SHELL': '/bin/bash', 16:52:28 INFO - 'SHLVL': '1', 16:52:28 INFO - 'TERM': 'linux', 16:52:28 INFO - 'TMOUT': '86400', 16:52:28 INFO - 'USER': 'cltbld', 16:52:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', 16:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:28 INFO - '_': '/tools/buildbot/bin/python'} 16:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:28 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 16:52:28 INFO - Cleaning up... 16:52:28 INFO - Return code: 0 16:52:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:52:28 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')]} 16:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:28 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')]} 16:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:28 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 0x7fabaa739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ad410>, '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 0x23ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', '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 16:52:28 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 16:52:28 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 16:52:28 INFO - Using env: {'DISPLAY': ':0', 16:52:28 INFO - 'HOME': '/home/cltbld', 16:52:28 INFO - 'LANG': 'en_US.UTF-8', 16:52:28 INFO - 'LANGUAGE': 'en_US:en', 16:52:28 INFO - 'LOGNAME': 'cltbld', 16:52:28 INFO - 'MAIL': '/var/mail/cltbld', 16:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:28 INFO - 'MOZ_NO_REMOTE': '1', 16:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:28 INFO - 'NO_EM_RESTART': '1', 16:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:28 INFO - 'PWD': '/builds/slave/test', 16:52:28 INFO - 'SHELL': '/bin/bash', 16:52:28 INFO - 'SHLVL': '1', 16:52:28 INFO - 'TERM': 'linux', 16:52:28 INFO - 'TMOUT': '86400', 16:52:28 INFO - 'USER': 'cltbld', 16:52:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', 16:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:28 INFO - '_': '/tools/buildbot/bin/python'} 16:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:29 INFO - Downloading/unpacking psutil>=0.7.1 16:52:29 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 16:52:29 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 16:52:29 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 16:52:29 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 16:52:29 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 16:52:29 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 16:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:52:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:31 INFO - Installing collected packages: psutil 16:52:31 INFO - Running setup.py install for psutil 16:52:31 INFO - building 'psutil._psutil_linux' extension 16:52:31 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 16:52:31 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 16:52:31 INFO - building 'psutil._psutil_posix' extension 16:52:31 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 16:52:31 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 16:52:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:31 INFO - Successfully installed psutil 16:52:31 INFO - Cleaning up... 16:52:31 INFO - Return code: 0 16:52:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:52:31 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')]} 16:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:31 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')]} 16:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:31 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 0x7fabaa739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ad410>, '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 0x23ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', '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 16:52:31 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 16:52:31 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 16:52:31 INFO - Using env: {'DISPLAY': ':0', 16:52:31 INFO - 'HOME': '/home/cltbld', 16:52:31 INFO - 'LANG': 'en_US.UTF-8', 16:52:31 INFO - 'LANGUAGE': 'en_US:en', 16:52:31 INFO - 'LOGNAME': 'cltbld', 16:52:31 INFO - 'MAIL': '/var/mail/cltbld', 16:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:31 INFO - 'MOZ_NO_REMOTE': '1', 16:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:31 INFO - 'NO_EM_RESTART': '1', 16:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:31 INFO - 'PWD': '/builds/slave/test', 16:52:31 INFO - 'SHELL': '/bin/bash', 16:52:31 INFO - 'SHLVL': '1', 16:52:31 INFO - 'TERM': 'linux', 16:52:31 INFO - 'TMOUT': '86400', 16:52:31 INFO - 'USER': 'cltbld', 16:52:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', 16:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:31 INFO - '_': '/tools/buildbot/bin/python'} 16:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:52:31 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 16:52:31 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 16:52:31 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 16:52:31 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 16:52:31 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 16:52:31 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 16:52:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:52:33 INFO - Installing collected packages: mozsystemmonitor 16:52:33 INFO - Running setup.py install for mozsystemmonitor 16:52:33 INFO - Successfully installed mozsystemmonitor 16:52:33 INFO - Cleaning up... 16:52:33 INFO - Return code: 0 16:52:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:52:33 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')]} 16:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:33 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')]} 16:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:33 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 0x7fabaa739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ad410>, '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 0x23ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', '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 16:52:33 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 16:52:33 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 16:52:33 INFO - Using env: {'DISPLAY': ':0', 16:52:33 INFO - 'HOME': '/home/cltbld', 16:52:33 INFO - 'LANG': 'en_US.UTF-8', 16:52:33 INFO - 'LANGUAGE': 'en_US:en', 16:52:33 INFO - 'LOGNAME': 'cltbld', 16:52:33 INFO - 'MAIL': '/var/mail/cltbld', 16:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:33 INFO - 'MOZ_NO_REMOTE': '1', 16:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:33 INFO - 'NO_EM_RESTART': '1', 16:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:33 INFO - 'PWD': '/builds/slave/test', 16:52:33 INFO - 'SHELL': '/bin/bash', 16:52:33 INFO - 'SHLVL': '1', 16:52:33 INFO - 'TERM': 'linux', 16:52:33 INFO - 'TMOUT': '86400', 16:52:33 INFO - 'USER': 'cltbld', 16:52:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', 16:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:33 INFO - '_': '/tools/buildbot/bin/python'} 16:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:34 INFO - Downloading/unpacking blobuploader==1.2.4 16:52:34 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 16:52:34 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 16:52:34 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 16:52:34 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 16:52:34 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 16:52:34 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 16:52:35 INFO - Downloading blobuploader-1.2.4.tar.gz 16:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:52:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:52:36 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 16:52:36 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 16:52:36 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 16:52:36 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 16:52:36 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 16:52:36 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 16:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:52:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:52:36 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 16:52:36 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 16:52:36 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 16:52:36 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 16:52:36 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 16:52:36 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 16:52:36 INFO - Downloading docopt-0.6.1.tar.gz 16:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:52:36 INFO - Installing collected packages: blobuploader, requests, docopt 16:52:36 INFO - Running setup.py install for blobuploader 16:52:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:52:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:52:36 INFO - Running setup.py install for requests 16:52:37 INFO - Running setup.py install for docopt 16:52:37 INFO - Successfully installed blobuploader requests docopt 16:52:37 INFO - Cleaning up... 16:52:37 INFO - Return code: 0 16:52:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:37 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 0x7fabaa739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ad410>, '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 0x23ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', '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 16:52:37 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 16:52:37 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 16:52:37 INFO - Using env: {'DISPLAY': ':0', 16:52:37 INFO - 'HOME': '/home/cltbld', 16:52:37 INFO - 'LANG': 'en_US.UTF-8', 16:52:37 INFO - 'LANGUAGE': 'en_US:en', 16:52:37 INFO - 'LOGNAME': 'cltbld', 16:52:37 INFO - 'MAIL': '/var/mail/cltbld', 16:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:37 INFO - 'MOZ_NO_REMOTE': '1', 16:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:37 INFO - 'NO_EM_RESTART': '1', 16:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:37 INFO - 'PWD': '/builds/slave/test', 16:52:37 INFO - 'SHELL': '/bin/bash', 16:52:37 INFO - 'SHLVL': '1', 16:52:37 INFO - 'TERM': 'linux', 16:52:37 INFO - 'TMOUT': '86400', 16:52:37 INFO - 'USER': 'cltbld', 16:52:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', 16:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:37 INFO - '_': '/tools/buildbot/bin/python'} 16:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:52:37 INFO - Running setup.py (path:/tmp/pip-HqZRyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:52:37 INFO - Running setup.py (path:/tmp/pip-xMyq0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:52:37 INFO - Running setup.py (path:/tmp/pip-NOMukV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:52:37 INFO - Running setup.py (path:/tmp/pip-2z9M99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:52:37 INFO - Running setup.py (path:/tmp/pip-JYiGZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:52:37 INFO - Running setup.py (path:/tmp/pip-54Rrqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:52:37 INFO - Running setup.py (path:/tmp/pip-jXuYmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:52:38 INFO - Running setup.py (path:/tmp/pip-CvNeRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:52:38 INFO - Running setup.py (path:/tmp/pip-JLj9QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:52:38 INFO - Running setup.py (path:/tmp/pip-q5fWfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:52:38 INFO - Running setup.py (path:/tmp/pip-WIXeQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:52:38 INFO - Running setup.py (path:/tmp/pip-F8yTqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:52:38 INFO - Running setup.py (path:/tmp/pip-1LVHAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:52:38 INFO - Running setup.py (path:/tmp/pip-2Dgg3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:38 INFO - Running setup.py (path:/tmp/pip-UT3RSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:52:38 INFO - Running setup.py (path:/tmp/pip-W3Hn8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:52:38 INFO - Running setup.py (path:/tmp/pip-gHmrFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:52:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:52:38 INFO - Running setup.py install for manifestparser 16:52:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:52:38 INFO - Running setup.py install for mozcrash 16:52:38 INFO - Running setup.py install for mozdebug 16:52:39 INFO - Running setup.py install for mozdevice 16:52:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:52:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:52:39 INFO - Running setup.py install for mozfile 16:52:39 INFO - Running setup.py install for mozhttpd 16:52:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:52:39 INFO - Running setup.py install for mozinfo 16:52:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:52:39 INFO - Running setup.py install for mozInstall 16:52:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:52:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:52:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:52:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:52:39 INFO - Running setup.py install for mozleak 16:52:39 INFO - Running setup.py install for mozlog 16:52:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:52:39 INFO - Running setup.py install for moznetwork 16:52:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:52:39 INFO - Running setup.py install for mozprocess 16:52:39 INFO - Running setup.py install for mozprofile 16:52:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:52:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:52:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:52:40 INFO - Running setup.py install for mozrunner 16:52:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:52:40 INFO - Running setup.py install for mozscreenshot 16:52:40 INFO - Running setup.py install for moztest 16:52:40 INFO - Running setup.py install for mozversion 16:52:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:52:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:52:40 INFO - Cleaning up... 16:52:40 INFO - Return code: 0 16:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:40 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')]} 16:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:40 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')]} 16:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:40 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 0x7fabaa739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ad410>, '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 0x23ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', '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 16:52:40 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 16:52:40 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 16:52:40 INFO - Using env: {'DISPLAY': ':0', 16:52:40 INFO - 'HOME': '/home/cltbld', 16:52:40 INFO - 'LANG': 'en_US.UTF-8', 16:52:40 INFO - 'LANGUAGE': 'en_US:en', 16:52:40 INFO - 'LOGNAME': 'cltbld', 16:52:40 INFO - 'MAIL': '/var/mail/cltbld', 16:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:40 INFO - 'MOZ_NO_REMOTE': '1', 16:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:40 INFO - 'NO_EM_RESTART': '1', 16:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:40 INFO - 'PWD': '/builds/slave/test', 16:52:40 INFO - 'SHELL': '/bin/bash', 16:52:40 INFO - 'SHLVL': '1', 16:52:40 INFO - 'TERM': 'linux', 16:52:40 INFO - 'TMOUT': '86400', 16:52:40 INFO - 'USER': 'cltbld', 16:52:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', 16:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:40 INFO - '_': '/tools/buildbot/bin/python'} 16:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:52:40 INFO - Running setup.py (path:/tmp/pip-lZzcqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:52:40 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)) 16:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:52:40 INFO - Running setup.py (path:/tmp/pip-M4BsWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:52:40 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)) 16:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:52:40 INFO - Running setup.py (path:/tmp/pip-eaRkio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:52:40 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)) 16:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:52:40 INFO - Running setup.py (path:/tmp/pip-YekZkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:52:41 INFO - Running setup.py (path:/tmp/pip-_uX_LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:52:41 INFO - Running setup.py (path:/tmp/pip-QIR7sR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:52:41 INFO - Running setup.py (path:/tmp/pip-mAuSOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:52:41 INFO - Running setup.py (path:/tmp/pip-VxAQBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:52:41 INFO - Running setup.py (path:/tmp/pip-9avv13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:52:41 INFO - Running setup.py (path:/tmp/pip-n7N3P7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:52:41 INFO - Running setup.py (path:/tmp/pip-AWGiRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:52:41 INFO - Running setup.py (path:/tmp/pip-T2eI7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:52:41 INFO - Running setup.py (path:/tmp/pip-q9Mp7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:52:41 INFO - Running setup.py (path:/tmp/pip-5ea4db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:41 INFO - Running setup.py (path:/tmp/pip-wn7Qhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:52:41 INFO - Running setup.py (path:/tmp/pip-7wUdnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:52:41 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)) 16:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:52:41 INFO - Running setup.py (path:/tmp/pip-JewTxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:52:42 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)) 16:52:42 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)) 16:52:42 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)) 16:52:42 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)) 16:52:42 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)) 16:52:42 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)) 16:52:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:43 INFO - Downloading blessings-1.6.tar.gz 16:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:52:43 INFO - Installing collected packages: blessings 16:52:43 INFO - Running setup.py install for blessings 16:52:44 INFO - Successfully installed blessings 16:52:44 INFO - Cleaning up... 16:52:44 INFO - Return code: 0 16:52:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:52:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:52:44 INFO - Reading from file tmpfile_stdout 16:52:44 INFO - Current package versions: 16:52:44 INFO - argparse == 1.2.1 16:52:44 INFO - blessings == 1.6 16:52:44 INFO - blobuploader == 1.2.4 16:52:44 INFO - docopt == 0.6.1 16:52:44 INFO - manifestparser == 1.1 16:52:44 INFO - mozInstall == 1.12 16:52:44 INFO - mozcrash == 0.17 16:52:44 INFO - mozdebug == 0.1 16:52:44 INFO - mozdevice == 0.48 16:52:44 INFO - mozfile == 1.2 16:52:44 INFO - mozhttpd == 0.7 16:52:44 INFO - mozinfo == 0.9 16:52:44 INFO - mozleak == 0.1 16:52:44 INFO - mozlog == 3.1 16:52:44 INFO - moznetwork == 0.27 16:52:44 INFO - mozprocess == 0.22 16:52:44 INFO - mozprofile == 0.28 16:52:44 INFO - mozrunner == 6.11 16:52:44 INFO - mozscreenshot == 0.1 16:52:44 INFO - mozsystemmonitor == 0.0 16:52:44 INFO - moztest == 0.7 16:52:44 INFO - mozversion == 1.4 16:52:44 INFO - psutil == 3.1.1 16:52:44 INFO - requests == 1.2.3 16:52:44 INFO - wsgiref == 0.1.2 16:52:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:44 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 0x7fabaa739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ad410>, '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 0x23ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', '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 16:52:44 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 16:52:44 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 16:52:44 INFO - Using env: {'DISPLAY': ':0', 16:52:44 INFO - 'HOME': '/home/cltbld', 16:52:44 INFO - 'LANG': 'en_US.UTF-8', 16:52:44 INFO - 'LANGUAGE': 'en_US:en', 16:52:44 INFO - 'LOGNAME': 'cltbld', 16:52:44 INFO - 'MAIL': '/var/mail/cltbld', 16:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:44 INFO - 'MOZ_NO_REMOTE': '1', 16:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:44 INFO - 'NO_EM_RESTART': '1', 16:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:44 INFO - 'PWD': '/builds/slave/test', 16:52:44 INFO - 'SHELL': '/bin/bash', 16:52:44 INFO - 'SHLVL': '1', 16:52:44 INFO - 'TERM': 'linux', 16:52:44 INFO - 'TMOUT': '86400', 16:52:44 INFO - 'USER': 'cltbld', 16:52:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', 16:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:44 INFO - '_': '/tools/buildbot/bin/python'} 16:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:44 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)) 16:52:44 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)) 16:52:44 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)) 16:52:44 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)) 16:52:44 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)) 16:52:44 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)) 16:52:44 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)) 16:52:44 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)) 16:52:44 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)) 16:52:44 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)) 16:52:44 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)) 16:52:44 INFO - Cleaning up... 16:52:44 INFO - Return code: 0 16:52:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:44 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 0x7fabaa739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ad410>, '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 0x23ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', '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 16:52:44 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 16:52:44 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 16:52:44 INFO - Using env: {'DISPLAY': ':0', 16:52:44 INFO - 'HOME': '/home/cltbld', 16:52:44 INFO - 'LANG': 'en_US.UTF-8', 16:52:44 INFO - 'LANGUAGE': 'en_US:en', 16:52:44 INFO - 'LOGNAME': 'cltbld', 16:52:44 INFO - 'MAIL': '/var/mail/cltbld', 16:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:44 INFO - 'MOZ_NO_REMOTE': '1', 16:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:44 INFO - 'NO_EM_RESTART': '1', 16:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:44 INFO - 'PWD': '/builds/slave/test', 16:52:44 INFO - 'SHELL': '/bin/bash', 16:52:44 INFO - 'SHLVL': '1', 16:52:44 INFO - 'TERM': 'linux', 16:52:44 INFO - 'TMOUT': '86400', 16:52:44 INFO - 'USER': 'cltbld', 16:52:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', 16:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:44 INFO - '_': '/tools/buildbot/bin/python'} 16:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:44 INFO - Downloading/unpacking jsonschema 16:52:44 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 16:52:44 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 16:52:44 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 16:52:44 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 16:52:44 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 16:52:44 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 16:52:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:52:46 INFO - Downloading/unpacking functools32 (from jsonschema) 16:52:46 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 16:52:46 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 16:52:46 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 16:52:46 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 16:52:46 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 16:52:46 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 16:52:46 INFO - Downloading functools32-3.2.3-2.tar.gz 16:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:52:46 INFO - warning: no files found matching '*.txt' 16:52:46 INFO - no previously-included directories found matching 'build' 16:52:46 INFO - no previously-included directories found matching 'dist' 16:52:46 INFO - no previously-included directories found matching '.git*' 16:52:46 INFO - Installing collected packages: jsonschema, functools32 16:52:46 INFO - Running setup.py install for functools32 16:52:47 INFO - warning: no files found matching '*.txt' 16:52:47 INFO - no previously-included directories found matching 'build' 16:52:47 INFO - no previously-included directories found matching 'dist' 16:52:47 INFO - no previously-included directories found matching '.git*' 16:52:47 INFO - Successfully installed jsonschema functools32 16:52:47 INFO - Cleaning up... 16:52:47 INFO - Return code: 0 16:52:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabaa739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ad410>, '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 0x23ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae7a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', '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 16: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', 'flake8'] in /builds/slave/test/build 16: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 flake8 16:52:47 INFO - Using env: {'DISPLAY': ':0', 16:52:47 INFO - 'HOME': '/home/cltbld', 16:52:47 INFO - 'LANG': 'en_US.UTF-8', 16:52:47 INFO - 'LANGUAGE': 'en_US:en', 16:52:47 INFO - 'LOGNAME': 'cltbld', 16:52:47 INFO - 'MAIL': '/var/mail/cltbld', 16:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:47 INFO - 'MOZ_NO_REMOTE': '1', 16:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:47 INFO - 'NO_EM_RESTART': '1', 16:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:47 INFO - 'PWD': '/builds/slave/test', 16:52:47 INFO - 'SHELL': '/bin/bash', 16:52:47 INFO - 'SHLVL': '1', 16:52:47 INFO - 'TERM': 'linux', 16:52:47 INFO - 'TMOUT': '86400', 16:52:47 INFO - 'USER': 'cltbld', 16:52:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', 16:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:47 INFO - '_': '/tools/buildbot/bin/python'} 16:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:47 INFO - Downloading/unpacking flake8 16:52:47 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 16:52:47 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 16:52:47 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 16:52:47 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 16:52:47 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 16:52:47 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 16:52:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:52:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:52:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:52:50 INFO - no previously-included directories found matching 'docs/_build' 16:52:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:52:50 INFO - Running setup.py install for pep8 16:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:52:50 INFO - no previously-included directories found matching 'docs/_build' 16:52:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:52:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:52:50 INFO - Cleaning up... 16:52:50 INFO - Return code: 0 16:52:50 INFO - Running post-action listener: _resource_record_post_action 16:52:50 INFO - Running post-action listener: _start_resource_monitoring 16:52:50 INFO - Starting resource monitoring. 16:52:50 INFO - ##### 16:52:50 INFO - ##### Running install step. 16:52:50 INFO - ##### 16:52:50 INFO - Running pre-action listener: _resource_record_pre_action 16:52:50 INFO - Running main action method: install 16:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:52:50 INFO - Reading from file tmpfile_stdout 16:52:50 INFO - Detecting whether we're running mozinstall >=1.0... 16:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:52:50 INFO - Reading from file tmpfile_stdout 16:52:50 INFO - Output received: 16:52:50 INFO - Usage: mozinstall [options] installer 16:52:50 INFO - Options: 16:52:50 INFO - -h, --help show this help message and exit 16:52:50 INFO - -d DEST, --destination=DEST 16:52:50 INFO - Directory to install application into. [default: 16:52:50 INFO - "/builds/slave/test"] 16:52:50 INFO - --app=APP Application being installed. [default: firefox] 16:52:50 INFO - mkdir: /builds/slave/test/build/application 16:52:50 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'] 16:52:50 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 16:53:06 INFO - Reading from file tmpfile_stdout 16:53:06 INFO - Output received: 16:53:06 INFO - /builds/slave/test/build/application/firefox/firefox 16:53:06 INFO - Running post-action listener: _resource_record_post_action 16:53:06 INFO - ##### 16:53:06 INFO - ##### Running run-tests step. 16:53:06 INFO - ##### 16:53:06 INFO - Running pre-action listener: _resource_record_pre_action 16:53:06 INFO - Running main action method: run_tests 16:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:06 INFO - Python 2.7.3 16:53:06 INFO - Return code: 0 16:53:06 INFO - grabbing minidump binary from tooltool 16: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')]} 16:53:06 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 0x23ad410>, '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 0x23ae310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ae7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:06 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 16:53:06 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 16:53:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:06 INFO - Return code: 0 16:53:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:53:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:53:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:53:07 INFO - Return code: 0 16:53:07 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/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 16:53:07 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/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 16:53:07 INFO - Using env: {'DISPLAY': ':0', 16:53:07 INFO - 'HOME': '/home/cltbld', 16:53:07 INFO - 'LANG': 'en_US.UTF-8', 16:53:07 INFO - 'LANGUAGE': 'en_US:en', 16:53:07 INFO - 'LOGNAME': 'cltbld', 16:53:07 INFO - 'MAIL': '/var/mail/cltbld', 16:53:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:07 INFO - 'MOZ_NO_REMOTE': '1', 16:53:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:07 INFO - 'NO_EM_RESTART': '1', 16:53:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:07 INFO - 'PWD': '/builds/slave/test', 16:53:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:07 INFO - 'SHELL': '/bin/bash', 16:53:07 INFO - 'SHLVL': '1', 16:53:07 INFO - 'TERM': 'linux', 16:53:07 INFO - 'TMOUT': '86400', 16:53:07 INFO - 'USER': 'cltbld', 16:53:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588', 16:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:07 INFO - '_': '/tools/buildbot/bin/python'} 16:53:07 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/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 16:53:07 INFO - mozversion application_buildid: 20160406160854 16:53:07 INFO - mozversion application_changeset: 133d8859d7b5e7d44d74c66aaa52c2da30cab3c4 16:53:07 INFO - mozversion application_display_name: Nightly 16:53:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:07 INFO - mozversion application_name: Firefox 16:53:07 INFO - mozversion application_remotingname: firefox 16:53:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:53:07 INFO - mozversion application_vendor: Mozilla 16:53:07 INFO - mozversion application_version: 48.0a1 16:53:07 INFO - mozversion platform_buildid: 20160406160854 16:53:07 INFO - mozversion platform_changeset: 133d8859d7b5e7d44d74c66aaa52c2da30cab3c4 16:53:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:53:07 INFO - mozversion platform_version: 48.0a1 16:53:07 INFO - using testdate: 1459986787 16:53:07 INFO - actual date: 1459986787 16:53:07 INFO - starting webserver on 'localhost:40449' 16:53:07 INFO - SUITE-START | Running 2 tests 16:53:07 INFO - TEST-START | dromaeo_css 16:53:07 INFO - operating with platform_type : linux_ 16:53:07 INFO - Initialising browser for dromaeo_css test... 16:53:07 INFO - TEST-INFO | started process 22633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEncor1/profile http://localhost:40449/getInfo.html) 16:53:12 INFO - PROCESS | 22633 | __metrics Screen width/height:1600/1200 16:53:12 INFO - PROCESS | 22633 | colorDepth:24 16:53:12 INFO - PROCESS | 22633 | Browser inner width/height: 1024/697 16:53:12 INFO - PROCESS | 22633 | __metrics 16:53:13 ERROR - PROCESS | 22633 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:53:14 INFO - TEST-INFO | 22633: exit 0 16:53:14 INFO - Browser initialized. 16:53:14 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:14 INFO - TEST-INFO | started process 22714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEncor1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:26 INFO - PROCESS | 22714 | RSS: Main: 154791936 16:53:26 INFO - PROCESS | 22714 | 16:54:16 INFO - PROCESS | 22714 | 1459986856959 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] 16:56:29 INFO - PROCESS | 22714 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40449/tests/dromaeo/cssquery-ext.html) 16:56:30 INFO - PROCESS | 22714 | RSS: Main: 232255488 16:56:30 INFO - PROCESS | 22714 | 16:59:33 INFO - PROCESS | 22714 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-ext.html (next: http://localhost:40449/tests/dromaeo/cssquery-jquery.html) 16:59:33 INFO - PROCESS | 22714 | RSS: Main: 232337408 16:59:33 INFO - PROCESS | 22714 | 17:02:35 INFO - PROCESS | 22714 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40449/tests/dromaeo/cssquery-mootools.html) 17:02:36 INFO - PROCESS | 22714 | RSS: Main: 242073600 17:02:36 INFO - PROCESS | 22714 | 17:05:37 INFO - PROCESS | 22714 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40449/tests/dromaeo/cssquery-prototype.html) 17:05:38 INFO - PROCESS | 22714 | RSS: Main: 223223808 17:05:38 INFO - PROCESS | 22714 | 17:08:41 INFO - PROCESS | 22714 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40449/tests/dromaeo/cssquery-yui.html) 17:08:41 INFO - PROCESS | 22714 | RSS: Main: 220000256 17:08:41 INFO - PROCESS | 22714 | 17:11:44 INFO - PROCESS | 22714 | Cycle 1(1): loaded http://localhost:40449/tests/dromaeo/cssquery-yui.html (next: http://localhost:40449/tests/dromaeo/cssquery-dojo.html) 17:11:45 INFO - PROCESS | 22714 | RSS: Main: 273330176 17:11:45 INFO - PROCESS | 22714 | 17:11:45 INFO - PROCESS | 22714 | __start_tp_report 17:11:45 INFO - PROCESS | 22714 | _x_x_mozilla_page_load 17:11:45 INFO - PROCESS | 22714 | _x_x_mozilla_page_load_details 17:11:45 INFO - PROCESS | 22714 | |i|pagename|runs| 17:11:45 INFO - PROCESS | 22714 | |0;dojo.html;2616.9084082057134;2665.8267212631167;2688.7176846431125;2707.86460676966;2719.374543854913;4627.4447066352;4710.2228132358205;4717.29240613908;4735.810567577293;4794.328793968843;4733.90532189356;4754.120487709776;4762.166620841347;4771.1888978873585;4839.4434640016325;4298.677599180059;4316.5036020857615;4350.717203381786;4379.146066517031;4494.831343850589;4411.6250118739945;4412.3602077698715;4461.063176732874;4468.039371535119;4484.148011877749;4205.179989901971;4282.336237883133;4301.2902871026245;4313.805878735465;4364.10535840152;4394.384786129945;4396.516383197845;4399.912001759979;4417.3815665806815;4462.598366147063;4367.978160109211;4370.060437006059;4371.693981421302;4391.934120988188;4413.558644135593;4507.3689683444345;4557.043020965568;4610.723356598614;4662.393888794435;4668.486466488684;5013.799448022075;5023.196288593807;5023.924641130386;5047.570956468705;5065.822696205652;5036.370453693288;5041.143005689041;5042.470540593222;5045.268436076748;5076.670016448956;4627.9074418511445;4666.32338310943;4692.741899195543;4693.530646935279;4751.619870410359;5207.37511498615;5227.477252274742;5227.529522343008;5228.189630607262;5256.78972841082;4991.700497970133;5007.173816320339;5009.599232061426;5021.6735912165595;5060.797568097235;4864.489228631013;4930.580900623487;4983.800647974041;5025.773840177128;5085.796568137233;4972.453030166679;4977.502249774993;4979.526944940298;4994.400671919393;5036.7733451994745;4954.677945933503;4960.975195124073;4963.6525443218625;4974.030064137531;5016.372953380827;4127.979360103241;4179.895502612399;4206.936895946563;4208.158368326347;4208.642265407413;3757.718171137121;3773.283076215565;3778.886633401002;3790.7346485746284;3798.2213646202463;4340.544242854455;4341.001569639001;4341.804618792162;4342.82628694855;4343.04453020335;5018.698878067327;5034.622403319766;5040.344755181803;5073.1122053640465;5134.589232861362;4354.259775838115;4363.956360436418;4368.584984426538;4368.825246990148;4410.448693913261;4386.407834942306;4545.886352841206;4553.704009239389;4570.611498022706;4598.97700511502;4783.6651434399255;4786;4800.279958006327;4805.543473370024;4859.7327147005835;5018.172001619692;5060.443351231435;5072.619553533574;5085.084684756779;5107.616928730435;4682.157211701926;4785.712857228577;4790.473047964791;4848.296996935495;4852.344933433941;4997.600191984705;5013.674111182761;5022.096022715946;5027.3464449621315;5039.395272567169;5079.238114282739;5081.745912704276;5081.974590127025;5089.00764350948;5097.515736005073;4747.501512341154;4881.023795240895;4907.901841963212;4931.48219436954;4940.629452790983;4889.071076495455;4906.313116163668;4913.754312284443;4924.539322925699;4964.801407943786;4835.564799168092;4845.41854977405;4848.539388758062;4894.681845680162;4909.337239472626;4801.471838097877;4902.583280421061;4921.286413469955;4975.353204083591;4975.800967961386;4728.101660684459;4741.122892264942;4748.382710247645;4752.192127338291;4800.279958006327 17:11:45 INFO - PROCESS | 22714 | |1;ext.html;535.3923297057838;539.2773683264426;562.024886821365;564.472218475725;575.8387651457591;27487.175384738464;27864.860675696593;27908.720912790865;27966;33918.32163356731;37069.814650926775;37581.24837503248;37650.4352434713;37721.43417848735;37760.43359349612;7635.885461718079;7761.844763104735;7807.258310460497;7807.375409967189;7808.414368922326;7646.847063058735;7777;7783.182765809594;7785.805354866117;7796.337311328544;7785.221477852226;8006.479578827358;8006.6797328107095;8017.679292828309;8019.558924259163;7913.802154946144;7973.242541958504;8002.079760827522;8005.759827205164;8006.519608823489;7882.132965373804;7976.960115199387;7988.520688758635;7994.120646728855;8001.799955001114;37028.81485592582;37672;37708.43437348442;37761.244775104344;37815.43276850849;3356.7650264481495;3421.059208717598;3547.9113022174392;3759.473673685686;3856.055266459707;30527.236819079477;30778;30801.075967721004;30881;31352.52971205411;3478.478228265755;3575.6960658344074;3606.801625910574;3721.6836568891677;3756.3050835595504;225965;229335;231067;231295;231593;57553;58250;59183.112253316234;59211;59388;62166;62666.373336266966;62713;62714.0592891107;62752.68623656852;14483.913706472056;14758.926205368904;14789.408423662933;14793.186374749492;14811.407543698131;10890.564377424815;11215.102791776639;11216.32702037864;11218;11226.21416500837;19536;20789.688154677693;21017;21025.68461473079;21171.68242476364;6321.494280457552;7731.884021739678;7932.127465978738;8384.37864164704;8614.267787238156;899.2356496977517;960.7213907966611;991.1030517381781;1027.4811220333684;1043.7025447747355;27409.588856167175;27630;27847.72152278492;27897.16308510748;28161.859190703915;994;1062.6440142552176;1076.7469644633504;1077.617445806743;1079.740862193068;14405.567832964818;14678.339474723449;14772.40910363595;14837.383196180694;14990.775138372934;287222;287564;291075;291080;291434;47521.287180692314;48241;48252.5174748255;48261.276080858814;48267;1084.978300433987;1224.7060705430633;1258.7482503499336;1274.5602767045355;1280.8142819291152;24490.87754561216;25433.237002889942;27299.590506142027;27699;27916.30209244785;38036.619633803304;43542.78228608837;44364.33453498265;44453.555464444944;44468.55531444774;204935;206398;206908;207154;207514;35041.12397190091;40231;41244.38133427941;41614;42457.787711061246;40437.393439099025;40611.1877762449;40917.59082409138;41353.586464134976;41684.58315416807;32250.83874580706;34370;34810.47784283187;34896.65103348934;35646.82176589101;35080.64919350876;35363.823180883934;35389.646103539664;35566.46650300196;35582;33968.66031339655;34669.47995780015;34677.306453871286;34696.13259668428;35117;30691.386172275983;31629.5255571162;32357.838210808794;32418.513722294658;32496.512552312208;24872.005119795005;24965.37586560278;25346.493070138862;25540;25609.61585576255 17:11:45 INFO - PROCESS | 22714 | |2;jquery.html;341.38209840189245;343.3836263906289;348.4981626457899;349.4321727193311;349.83382893125764;14925.552233433002;15282.923585382072;15825.60435989101;15896.84103158968;15898.52304430869;15437.382504699826;15687.529374118767;15969.760453593177;16679.915805472636;16727.83272167278;4914.262860570907;4995.0509403213455;5017.122003649365;5040.823571175009;5051.0150520648485;4630.722156670594;4946.455889852114;4986.252062190664;4991.475895031006;4995.450500444967;4928.137575924216;4937.481564435737;4937.679050861682;4938.901221975559;4939.185034469308;4750.738709370983;4929.901401971958;4954.7274899880495;4958.578520825734;4964.156093464102;4359.128174365108;4370.104128653618;4383.145286669101;4391.363252328427;4393.209222339978;19088.90455547727;19804.70292945607;19928.900355498274;19953.401397958085;19961.301354452524;1938.3118992757509;1973.062795172296;1982.8215460608615;2063.1128614695676;2307.457747429353;12268;12674.429650665743;12729.427175777113;12861.742765144645;13090.672733181651;1582.2958783341417;1674.8660107191395;1709.8119206887231;1737.9659102833793;1766.4788887278155;61153.694231529;61538.38461615416;62170;62362.06456903196;62780.68609656968;8716.302695784449;8864.113588641085;9100.180983711498;9158.313126515539;9263.397879137834;12185.51257949672;12247.632571022883;12268.631941041784;12278.631641050782;12284.324362159989;6982.299381327803;7066.7173313066905;7096.077509923677;7218.267615772177;7243.529170603894;6955.547889387275;6987.336203060701;7067.92932070683;7091.3972312353;7102.751403700846;5470.9452905471235;5561.443855614406;5601.439856014366;5601.691906945157;5631.18347839561;1638.655882264714;1691.8561922236747;1699.8640108791267;1720.8107108218087;1743.119724539125;860.7288704058202;912.926965842731;947.2138125355938;956.5695437053354;969.3892847506027;15569;16254.529685327125;16256.349746010028;16329.183540823149;16548.255328510248;836.2181360428019;869.0917990699734;900.7883147460342;910.2217603948661;950.273041123541;8838.55807209637;9489.952550237205;9557.139857412867;9586.568604412818;9644;290988;294019;295094;295478;386436;48553.02893942101;61699;63432.36567634357;63473.365266346744;66077.33922660808;889.1020069729619;962.9662961796444;972.1008067537499;1022.0954455306958;1025.410389026313;13617.455301787817;14590.5622831311;14900.063577842915;15035.849641503444;15375.538733838002;32377.190570235933;33512.49731254082;33896.49155262722;33976;34089.318213635095;42748;43344.56655433405;43478.78260608677;43494;43992.78003609961;7452.292032256927;7453.142888567884;7518.082888863305;7561.886571701539;7623.618819058914;6334.746610135543;8165.38759593021;9553.426794392359;10071.748206294902;11118.388488633203;4942.159832828356;7644.7768357062605;9618.605302231277;10003.699889003341;10654.164500779558;8861.202491775513;9330.253579713471;9554.856677149988;9554.904450955402;9697.466639334903;9949.950250248703;10138.391696497938;10236.33463824849;10318.43248621333;10526.894731052591;7202.639868006683;7314.158871729606;7420.888686669812;7518.173000969779;7524.887126693214;8727.607257673293;10565.9471702641;10566.894331056592;10592.152627789912;10708.785824283626 17:11:45 INFO - PROCESS | 22714 | |3;mootools.html;1314.1655049043866;1421.4598452588016;1436.088084066618;1586.1434825194397;1749.8862573932693;6804.183497980243;7279.417646588274;7471.663775130119;7474.96262518688;7480.3267705906455;7256.9637151814295;7553.924460755391;7555.622218889047;7560.130584982729;7580.6209689515445;1915.2721965653031;1963.518937860219;1969.9507512312164;2240.1935303290843;2264;2147.8389120816;2204.228520017989;2207.547452772186;2208.7459942106702;2210.5799898019327;2186.7485239197536;2208.9116435342567;2226.198568515333;2226.532428190082;2261.796438320551;2110.725605671253;2113.7991890770354;2117.100232401231;2117.4600476878372;2121.374194612593;2135.252661568454;2195.6267434536007;2197.340797760681;2205.415564875293;2210.425289424745;7736.149023607399;7783.766487005399;7801.648925798353;7802.570858602775;7819.061712594468;4669.322948172496;4785.401824771903;4798.424189097295;4803.111424386465;4809.350737650442;2939.4415061138316;3007.593974813394;3033.393321335742;3035.3929214157038;3045.649750278702;956.583886009588;984.4388698441891;993.9155171810405;1011.1607365886297;1018.1651046142166;10808.945955270174;10839.67480975572;10852.348859068481;10855.674329770041;10870.565177392895;4224.134052519226;4232.153569286155;4307.827686892552;4325.9134817303475;4362.389265502832;9088.81822363549;9195.448273103635;9198.770030749285;9200;9209.585568649427;4793.448753393404;4820.831270905502;4824.445188803263;4826.734529600905;4828.782704778223;3791.658750712449;4023.8994025149605;4134.607212314885;4365.192439398721;4365.672574556921;3563.3051554946537;3576.624454432247;3590.9281814363567;3602.081469225383;3680.5583330000036;1187.9940600296943;1189.4171855790773;1189.7501524679742;1191.684203686024;1193.0455635491571;1202.8195770634475;1226.0436859249799;1244.6452760963082;1251.0179509085324;1251.618256431779;7109.360157585842;7236.746713864989;7259.382952448996;7286.562806231643;7325.084364454443;444.0652426641937;455.0466772112419;457.3756821938097;462.6506987224624;467.43207003490244;5236.659617124875;5240.502152295526;5244.134717771525;5251.842444726664;5268.420473747885;9012.27901767857;9102.317326200562;9124.45253284805;9219.07809219086;9239.538023098952;8885.955570222108;8989.910100899038;8990.505522196212;9071.002189759121;9102.954485227532;7027.367536921702;7153.749618763319;7231.168415632164;7248.818779530554;7298.781036568911;6832.385085342343;6866.553674011173;6873.793786186422;6888.276730943379;6906.654667266516;7833.295003449717;8258.83482330338;8265;8278.048024477263;8378.413511054168;8245.175482451707;8598.183172598594;8617.69838055665;8639.611217495354;8649.178328058824;6605.669716514251;6613.074169616161;6662.600243985376;6737.898931516129;6747.359000894907;7235.131784185932;7249.927500724925;7263.309985551364;7284.927150728425;7332;6471.514636402195;6582.901256481253;6611.669416529058;6702.262751097473;6883;6609;6628.867422651617;6656.600603963778;6665.433438157811;6765.526413151032;6732.596044237362;6858.965705171442;6913.619750913748;6913.654317284217;6960.303969603202;6448.709808058742;6475.061116138039;6487.772927947499;6527.5430719849155;6536.281009089092;6512.218533775977;6583.275839657729;6584.308647592125;6592.2089349276475;6594.538382313192 17:11:45 INFO - PROCESS | 22714 | |4;prototype.html;301.64104715388686;312.2661744899486;316.76559346083906;318.56356791196066;320.20269528873115;5281.075811732951;5335.4664533546675;5447.346318441782;5458.972705136479;5478.04134276501;5310;5352.357717073956;5352.384475785286;5360.973195134028;5375.75809088591;3911.1199980004412;3989.8404063837556;4112.856050038249;4126.773027483488;4131.194417088669;4104.548499665035;4113.71204015719;4121.258173528764;4124.463819703435;4130.566290539495;4080.06158583526;4082.4896887889013;4083.693722970774;4084.938725919099;4097.89755256118;3882.3594106972314;3927.273454410943;4024.5371782245124;4039.192161567669;4045.2920738870876;3503.5795704515367;3505.4040813061843;3506.719462443024;3510.385682505577;3518.1556426457723;5128.051310507568;5128.743562821881;5148.304978827848;5150.536451719326;5155.175171972466;4646.372739680134;4674.135284972257;4683.250679891235;4687.20317546018;4689.554492323224;5602.859928501779;5609.186667933127;5613.382527921925;5618.0449323615085;5618.747156377973;3869.9226015479535;3872.419137129425;3877.3408520551575;3879.0884142226555;3879.4180872869297;5654.491095801398;5891.734871930774;5904.409559044104;5906.055031194988;5914.615549989237;3968.1865217630316;3977.8607748729232;3993.4409182714444;4002.2595819773437;4006.198760247962;4042.959570404317;4047.3524236122666;4050.736702114353;4052.5339585947404;4054.290499162694;4660.766961651904;4669.556392142741;4673.859784206479;4674.813007479731;4682.41469816273;5553.1670249462095;5584.553235741131;5586.692731899703;5589.161625756169;5591.161325801162;1402.067625029344;1418.3475601223347;1420.6874487612708;1421.9360128794228;1428.271581493425;926.8841394825647;961.4663861556763;974.8440249560178;1007.5717819926502;1011.0193112680688;4852.902941941142;4856.587190088882;4862.732549709729;4936.111499929975;4937.333459982929;5779.219805326311;5781.682007489544;5785.1611516329895;5796.594238403271;5798.9420105799245;4928.802847886116;4932.334134891816;4938.481459446706;4939.456659767423;4941.925871111936;3065.57082008519;3107.0523490335213;3108.347247078094;3109.891153809606;3110.5178697301953;5398.865028374322;5416.295881535454;5440.319960004999;5442.727863606883;5444.455554444603;5800.274965629296;5918.674472903946;5944.673042982591;5995.790147344822;6021.337652858269;5485.424030476823;5516.7517461714315;5518.420565840529;5519.641223320471;5531.170324451365;5863.560232982629;5865.354810970704;5870.442307980735;5873;5881.823545293477;5734;5734.455226753452;5741.655500669973;5746.2529871116485;5750.137479378127;5387.191921211849;5519.503244707996;5528.6406383586545;5533.7786488540005;5535;3955.5055618047745;4025.718199726108;4033.495813023372;4034.193161367797;4034.495688038995;5571.387147413862;5624.6625202487985;5810.767569297181;5846.269216347957;5848.0350742127075;5555.333359996826;5584.4136365681015;5620.494155526022;5625.915611265917;5659.9151012735665;5362.168863826113;5462.890742185214;5645.68948707825;5676.801311954062;5677.914831277451;5570.997220500349;5579.2746942897165;5579.804706835242;5584.972075139598;5587.161925711176;5644.604877658525;5646.971765141148;5656.151577263443;5659;5672.234248376416;5557.388687244319;5559.610827242216;5569.415211402745;5575.470330318613;5576.275084239023 17:11:45 INFO - PROCESS | 22714 | |5;yui.html;670.7216505150362;681.1077488490079;716.6595866963191;746.220199891114;774.254792122971;12525;12776.68058298543;12805.10364274501;12805.615831525069;12814.03894707896;12001.039916806656;12078.094142939293;12083.818742718866;12092.214006089598;12202.755944881097;799.2167675677839;806.4072906413782;813.1055838577577;813.4712436915993;813.9511629302232;662.2384258103172;790.9683612655516;817.791463176889;818.97133600324;819.7540737778672;849.0575461238021;850.5237067242364;851.5061264466594;852.722865068852;856.9828603427927;686.5262968551683;843.8354520868434;844.6114787197865;846.1369403208723;852.2500199824146;624.8156793745856;632.9525285603598;633.6926590603599;633.8066889598671;634;12117.39413029345;12217.144799864012;12226.694332641755;12298.200616959959;12306.138570300083;12237.326947017911;12719.491220351174;12886;12970.092093553456;13063.085584009123;9941.304108712393;9957.153641940444;10095.899041009568;10151.375779875185;10162.339447935861;3312.585926759155;3360.630330663625;3379.205886616643;3507.4563442666426;3509.0876372143425;39649.20701585952;40239.39640905389;40259.7987010066;40979.7951010246;41121.794391028154;8874.51190184546;9039.276857851357;9170.587323570455;9219.631214751334;9350.953245233866;16910.915445422695;16952.15239238058;16999;17013.31946722142;17020.574485637957;6427.228732552124;6482.2869484357625;6487.124238227873;6516.739330426824;6641.701123449457;3784.4323351497496;3785.375413056815;3830.444585535082;3891.610838916086;3893.649571538575;2832.730890565393;2872.0665783620407;2878.985605072003;2890.118513853295;2890.9710902891125;499.84504803511027;506.1521950732508;518.4608007672055;522.8666689994027;524.2320001198262;475.8929240920765;552.5883217003358;586.8356860079184;605.577846933275;610.5970059760625;8213.671453141927;8330.083690794008;8343.624536895853;8368.37237207212;8465;483.48750324655276;517.3068088761003;517.4153206876206;551.8344496650989;558.2909704675039;3807.8667246646232;3819.6753275971855;3834.5206849143856;3856.4793752843566;3917.8628747993685;53029.73485132627;53406;53469.7326513365;53525.1971220432;53673.731631341594;43415;44750.32874506885;45251.32123018157;46025.53974460279;46308.3053754194;42080.36879446811;42365.152696945275;42481;42608.147837043085;42622.78688606537;8840.425372350777;8910.153535414125;8938.642454301755;8974.102589741235;9007.189352958265;30564.541531876595;31316.843415782776;32513;32636.83681581577;32877.67122328746;38980;41369.1726165481;41522;42263.78868105763;42427.1514569713;10398.324108932895;10456.315526709936;10663.733406664895;10725.457769630808;10817.242793004729;10862.619808306672;11330.150238731963;11358.488868000795;11431.828522572334;11826.82259766087;10771.13830893511;11225.214235003472;11285.153613478858;11464.31214127155;11470.197086203885;10828.837567436653;11047.337159770439;11436.942815286204;11653.941730291293;11691.123165762432;10905.291156074829;10971.396573188551;11367.374794386387;11465.770684586429;11555.42222888869;8899.599518021834;9220.216281615869;9529.761755956157;9624.278179136452;9842.901570984484;9459.148676619137;9542.761430964281;9563.282753793632;9745.22038236925;9764.316497845082 17:11:45 INFO - PROCESS | 22714 | __end_tp_report 17:11:45 INFO - PROCESS | 22714 | __start_cc_report 17:11:45 INFO - PROCESS | 22714 | _x_x_mozilla_cycle_collect,1081 17:11:45 INFO - PROCESS | 22714 | __end_cc_report 17:11:45 INFO - PROCESS | 22714 | __startTimestamp1459987905104__endTimestamp 17:11:45 INFO - PROCESS | 22714 | 17:11:45 INFO - PROCESS | 22714 | ------- Summary: start ------- 17:11:45 INFO - PROCESS | 22714 | Number of tests: 6 17:11:45 INFO - PROCESS | 22714 | 17:11:45 INFO - PROCESS | 22714 | [#0] dojo.html Cycles:165 Average:4667.31 Median:4790.47 stddev:480.08 (10.0%) stddev-sans-first:453.81 17:11:45 INFO - PROCESS | 22714 | Values: 2616.9 2665.8 2688.7 2707.9 2719.4 4627.4 4710.2 4717.3 4735.8 4794.3 4733.9 4754.1 4762.2 4771.2 4839.4 4298.7 4316.5 4350.7 4379.1 4494.8 4411.6 4412.4 4461.1 4468.0 4484.1 4205.2 4282.3 4301.3 4313.8 4364.1 4394.4 4396.5 4399.9 4417.4 4462.6 4368.0 4370.1 4371.7 4391.9 4413.6 4507.4 4557.0 4610.7 4662.4 4668.5 5013.8 5023.2 5023.9 5047.6 5065.8 5036.4 5041.1 5042.5 5045.3 5076.7 4627.9 4666.3 4692.7 4693.5 4751.6 5207.4 5227.5 5227.5 5228.2 5256.8 4991.7 5007.2 5009.6 5021.7 5060.8 4864.5 4930.6 4983.8 5025.8 5085.8 4972.5 4977.5 4979.5 4994.4 5036.8 4954.7 4961.0 4963.7 4974.0 5016.4 4128.0 4179.9 4206.9 4208.2 4208.6 3757.7 3773.3 3778.9 3790.7 3798.2 4340.5 4341.0 4341.8 4342.8 4343.0 5018.7 5034.6 5040.3 5073.1 5134.6 4354.3 4364.0 4368.6 4368.8 4410.4 4386.4 4545.9 4553.7 4570.6 4599.0 4783.7 4786.0 4800.3 4805.5 4859.7 5018.2 5060.4 5072.6 5085.1 5107.6 4682.2 4785.7 4790.5 4848.3 4852.3 4997.6 5013.7 5022.1 5027.3 5039.4 5079.2 5081.7 5082.0 5089.0 5097.5 4747.5 4881.0 4907.9 4931.5 4940.6 4889.1 4906.3 4913.8 4924.5 4964.8 4835.6 4845.4 4848.5 4894.7 4909.3 4801.5 4902.6 4921.3 4975.4 4975.8 4728.1 4741.1 4748.4 4752.2 4800.3 17:11:45 INFO - PROCESS | 22714 | 17:11:45 INFO - PROCESS | 22714 | [#1] ext.html Cycles:180 Average:41395.48 Median:35376.73 stddev:63721.05 (180.1%) stddev-sans-first:63825.95 17:11:45 INFO - PROCESS | 22714 | Values: 535.4 539.3 562.0 564.5 575.8 27487.2 27864.9 27908.7 27966.0 33918.3 37069.8 37581.2 37650.4 37721.4 37760.4 7635.9 7761.8 7807.3 7807.4 7808.4 7646.8 7777.0 7783.2 7785.8 7796.3 7785.2 8006.5 8006.7 8017.7 8019.6 7913.8 7973.2 8002.1 8005.8 8006.5 7882.1 7977.0 7988.5 7994.1 8001.8 37028.8 37672.0 37708.4 37761.2 37815.4 3356.8 3421.1 3547.9 3759.5 3856.1 30527.2 30778.0 30801.1 30881.0 31352.5 3478.5 3575.7 3606.8 3721.7 3756.3 225965.0 229335.0 231067.0 231295.0 231593.0 57553.0 58250.0 59183.1 59211.0 59388.0 62166.0 62666.4 62713.0 62714.1 62752.7 14483.9 14758.9 14789.4 14793.2 14811.4 10890.6 11215.1 11216.3 11218.0 11226.2 19536.0 20789.7 21017.0 21025.7 21171.7 6321.5 7731.9 7932.1 8384.4 8614.3 899.2 960.7 991.1 1027.5 1043.7 27409.6 27630.0 27847.7 27897.2 28161.9 994.0 1062.6 1076.7 1077.6 1079.7 14405.6 14678.3 14772.4 14837.4 14990.8 287222.0 287564.0 291075.0 291080.0 291434.0 47521.3 48241.0 48252.5 48261.3 48267.0 1085.0 1224.7 1258.7 1274.6 1280.8 24490.9 25433.2 27299.6 27699.0 27916.3 38036.6 43542.8 44364.3 44453.6 44468.6 204935.0 206398.0 206908.0 207154.0 207514.0 35041.1 40231.0 41244.4 41614.0 42457.8 40437.4 40611.2 40917.6 41353.6 41684.6 32250.8 34370.0 34810.5 34896.7 35646.8 35080.6 35363.8 35389.6 35566.5 35582.0 33968.7 34669.5 34677.3 34696.1 35117.0 30691.4 31629.5 32357.8 32418.5 32496.5 24872.0 24965.4 25346.5 25540.0 25609.6 17:11:45 INFO - PROCESS | 22714 | 17:11:45 INFO - PROCESS | 22714 | [#2] jquery.html Cycles:180 Average:20906.54 Median:26651.88 stddev:51916.59 (194.8%) stddev-sans-first:52039.27 17:11:45 INFO - PROCESS | 22714 | Values: 341.4 343.4 348.5 349.4 349.8 14925.6 15282.9 15825.6 15896.8 15898.5 15437.4 15687.5 15969.8 16679.9 16727.8 4914.3 4995.1 5017.1 5040.8 5051.0 4630.7 4946.5 4986.3 4991.5 4995.5 4928.1 4937.5 4937.7 4938.9 4939.2 4750.7 4929.9 4954.7 4958.6 4964.2 4359.1 4370.1 4383.1 4391.4 4393.2 19088.9 19804.7 19928.9 19953.4 19961.3 1938.3 1973.1 1982.8 2063.1 2307.5 12268.0 12674.4 12729.4 12861.7 13090.7 1582.3 1674.9 1709.8 1738.0 1766.5 61153.7 61538.4 62170.0 62362.1 62780.7 8716.3 8864.1 9100.2 9158.3 9263.4 12185.5 12247.6 12268.6 12278.6 12284.3 6982.3 7066.7 7096.1 7218.3 7243.5 6955.5 6987.3 7067.9 7091.4 7102.8 5470.9 5561.4 5601.4 5601.7 5631.2 1638.7 1691.9 1699.9 1720.8 1743.1 860.7 912.9 947.2 956.6 969.4 15569.0 16254.5 16256.3 16329.2 16548.3 836.2 869.1 900.8 910.2 950.3 8838.6 9490.0 9557.1 9586.6 9644.0 290988.0 294019.0 295094.0 295478.0 386436.0 48553.0 61699.0 63432.4 63473.4 66077.3 889.1 963.0 972.1 1022.1 1025.4 13617.5 14590.6 14900.1 15035.8 15375.5 32377.2 33512.5 33896.5 33976.0 34089.3 42748.0 43344.6 43478.8 43494.0 43992.8 7452.3 7453.1 7518.1 7561.9 7623.6 6334.7 8165.4 9553.4 10071.7 11118.4 4942.2 7644.8 9618.6 10003.7 10654.2 8861.2 9330.3 9554.9 9554.9 9697.5 9950.0 10138.4 10236.3 10318.4 10526.9 7202.6 7314.2 7420.9 7518.2 7524.9 8727.6 10565.9 10566.9 10592.2 10708.8 17:11:45 INFO - PROCESS | 22714 | 17:11:45 INFO - PROCESS | 22714 | [#3] mootools.html Cycles:180 Average:5335.67 Median:6500.00 stddev:2814.66 (43.3%) stddev-sans-first:2806.32 17:11:45 INFO - PROCESS | 22714 | Values: 1314.2 1421.5 1436.1 1586.1 1749.9 6804.2 7279.4 7471.7 7475.0 7480.3 7257.0 7553.9 7555.6 7560.1 7580.6 1915.3 1963.5 1970.0 2240.2 2264.0 2147.8 2204.2 2207.5 2208.7 2210.6 2186.7 2208.9 2226.2 2226.5 2261.8 2110.7 2113.8 2117.1 2117.5 2121.4 2135.3 2195.6 2197.3 2205.4 2210.4 7736.1 7783.8 7801.6 7802.6 7819.1 4669.3 4785.4 4798.4 4803.1 4809.4 2939.4 3007.6 3033.4 3035.4 3045.6 956.6 984.4 993.9 1011.2 1018.2 10808.9 10839.7 10852.3 10855.7 10870.6 4224.1 4232.2 4307.8 4325.9 4362.4 9088.8 9195.4 9198.8 9200.0 9209.6 4793.4 4820.8 4824.4 4826.7 4828.8 3791.7 4023.9 4134.6 4365.2 4365.7 3563.3 3576.6 3590.9 3602.1 3680.6 1188.0 1189.4 1189.8 1191.7 1193.0 1202.8 1226.0 1244.6 1251.0 1251.6 7109.4 7236.7 7259.4 7286.6 7325.1 444.1 455.0 457.4 462.7 467.4 5236.7 5240.5 5244.1 5251.8 5268.4 9012.3 9102.3 9124.5 9219.1 9239.5 8886.0 8989.9 8990.5 9071.0 9103.0 7027.4 7153.7 7231.2 7248.8 7298.8 6832.4 6866.6 6873.8 6888.3 6906.7 7833.3 8258.8 8265.0 8278.0 8378.4 8245.2 8598.2 8617.7 8639.6 8649.2 6605.7 6613.1 6662.6 6737.9 6747.4 7235.1 7249.9 7263.3 7284.9 7332.0 6471.5 6582.9 6611.7 6702.3 6883.0 6609.0 6628.9 6656.6 6665.4 6765.5 6732.6 6859.0 6913.6 6913.7 6960.3 6448.7 6475.1 6487.8 6527.5 6536.3 6512.2 6583.3 6584.3 6592.2 6594.5 17:11:45 INFO - PROCESS | 22714 | 17:11:45 INFO - PROCESS | 22714 | [#4] prototype.html Cycles:180 Average:4641.79 Median:5352.37 stddev:1375.85 (25.7%) stddev-sans-first:1340.59 17:11:45 INFO - PROCESS | 22714 | Values: 301.6 312.3 316.8 318.6 320.2 5281.1 5335.5 5447.3 5459.0 5478.0 5310.0 5352.4 5352.4 5361.0 5375.8 3911.1 3989.8 4112.9 4126.8 4131.2 4104.5 4113.7 4121.3 4124.5 4130.6 4080.1 4082.5 4083.7 4084.9 4097.9 3882.4 3927.3 4024.5 4039.2 4045.3 3503.6 3505.4 3506.7 3510.4 3518.2 5128.1 5128.7 5148.3 5150.5 5155.2 4646.4 4674.1 4683.3 4687.2 4689.6 5602.9 5609.2 5613.4 5618.0 5618.7 3869.9 3872.4 3877.3 3879.1 3879.4 5654.5 5891.7 5904.4 5906.1 5914.6 3968.2 3977.9 3993.4 4002.3 4006.2 4043.0 4047.4 4050.7 4052.5 4054.3 4660.8 4669.6 4673.9 4674.8 4682.4 5553.2 5584.6 5586.7 5589.2 5591.2 1402.1 1418.3 1420.7 1421.9 1428.3 926.9 961.5 974.8 1007.6 1011.0 4852.9 4856.6 4862.7 4936.1 4937.3 5779.2 5781.7 5785.2 5796.6 5798.9 4928.8 4932.3 4938.5 4939.5 4941.9 3065.6 3107.1 3108.3 3109.9 3110.5 5398.9 5416.3 5440.3 5442.7 5444.5 5800.3 5918.7 5944.7 5995.8 6021.3 5485.4 5516.8 5518.4 5519.6 5531.2 5863.6 5865.4 5870.4 5873.0 5881.8 5734.0 5734.5 5741.7 5746.3 5750.1 5387.2 5519.5 5528.6 5533.8 5535.0 3955.5 4025.7 4033.5 4034.2 4034.5 5571.4 5624.7 5810.8 5846.3 5848.0 5555.3 5584.4 5620.5 5625.9 5659.9 5362.2 5462.9 5645.7 5676.8 5677.9 5571.0 5579.3 5579.8 5585.0 5587.2 5644.6 5647.0 5656.2 5659.0 5672.2 5557.4 5559.6 5569.4 5575.5 5576.3 17:11:45 INFO - PROCESS | 22714 | 17:11:45 INFO - PROCESS | 22714 | [#5] yui.html Cycles:180 Average:12766.07 Median:42544.57 stddev:14319.23 (33.7%) stddev-sans-first:14330.59 17:11:45 INFO - PROCESS | 22714 | Values: 670.7 681.1 716.7 746.2 774.3 12525.0 12776.7 12805.1 12805.6 12814.0 12001.0 12078.1 12083.8 12092.2 12202.8 799.2 806.4 813.1 813.5 814.0 662.2 791.0 817.8 819.0 819.8 849.1 850.5 851.5 852.7 857.0 686.5 843.8 844.6 846.1 852.3 624.8 633.0 633.7 633.8 634.0 12117.4 12217.1 12226.7 12298.2 12306.1 12237.3 12719.5 12886.0 12970.1 13063.1 9941.3 9957.2 10095.9 10151.4 10162.3 3312.6 3360.6 3379.2 3507.5 3509.1 39649.2 40239.4 40259.8 40979.8 41121.8 8874.5 9039.3 9170.6 9219.6 9351.0 16910.9 16952.2 16999.0 17013.3 17020.6 6427.2 6482.3 6487.1 6516.7 6641.7 3784.4 3785.4 3830.4 3891.6 3893.6 2832.7 2872.1 2879.0 2890.1 2891.0 499.8 506.2 518.5 522.9 524.2 475.9 552.6 586.8 605.6 610.6 8213.7 8330.1 8343.6 8368.4 8465.0 483.5 517.3 517.4 551.8 558.3 3807.9 3819.7 3834.5 3856.5 3917.9 53029.7 53406.0 53469.7 53525.2 53673.7 43415.0 44750.3 45251.3 46025.5 46308.3 42080.4 42365.2 42481.0 42608.1 42622.8 8840.4 8910.2 8938.6 8974.1 9007.2 30564.5 31316.8 32513.0 32636.8 32877.7 38980.0 41369.2 41522.0 42263.8 42427.2 10398.3 10456.3 10663.7 10725.5 10817.2 10862.6 11330.2 11358.5 11431.8 11826.8 10771.1 11225.2 11285.2 11464.3 11470.2 10828.8 11047.3 11436.9 11653.9 11691.1 10905.3 10971.4 11367.4 11465.8 11555.4 8899.6 9220.2 9529.8 9624.3 9842.9 9459.1 9542.8 9563.3 9745.2 9764.3 17:11:45 INFO - PROCESS | 22714 | -------- Summary: end -------- 17:11:45 INFO - PROCESS | 22714 | 17:11:45 INFO - TEST-INFO | 22714: exit 0 17:11:45 INFO - TEST-OK | dromaeo_css | took 1118431ms 17:11:45 INFO - TEST-START | kraken 17:11:45 INFO - operating with platform_type : linux_ 17:11:45 INFO - Initialising browser for kraken test... 17:11:45 INFO - TEST-INFO | started process 22892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2M9jcm/profile http://localhost:40449/getInfo.html) 17:11:50 INFO - PROCESS | 22892 | __metrics Screen width/height:1600/1200 17:11:50 INFO - PROCESS | 22892 | colorDepth:24 17:11:50 INFO - PROCESS | 22892 | Browser inner width/height: 1024/697 17:11:50 INFO - PROCESS | 22892 | __metrics 17:11:51 ERROR - PROCESS | 22892 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:11:52 INFO - TEST-INFO | 22892: exit 0 17:11:52 INFO - Browser initialized. 17:11:52 INFO - Running cycle 1/1 for kraken test... 17:11:52 INFO - TEST-INFO | started process 22974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2M9jcm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:04 INFO - PROCESS | 22974 | RSS: Main: 154697728 17:12:04 INFO - PROCESS | 22974 | 17:12:07 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40449/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:07 INFO - PROCESS | 22974 | RSS: Main: 195493888 17:12:07 INFO - PROCESS | 22974 | 17:12:10 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40449/tests/kraken/driver.html?testName=audio-dft) 17:12:11 INFO - PROCESS | 22974 | RSS: Main: 185163776 17:12:11 INFO - PROCESS | 22974 | 17:12:14 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40449/tests/kraken/driver.html?testName=audio-fft) 17:12:14 INFO - PROCESS | 22974 | RSS: Main: 171311104 17:12:14 INFO - PROCESS | 22974 | 17:12:16 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40449/tests/kraken/driver.html?testName=audio-oscillator) 17:12:17 INFO - PROCESS | 22974 | RSS: Main: 172756992 17:12:17 INFO - PROCESS | 22974 | 17:12:19 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40449/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:20 INFO - PROCESS | 22974 | RSS: Main: 174002176 17:12:20 INFO - PROCESS | 22974 | 17:12:23 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40449/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:23 INFO - PROCESS | 22974 | RSS: Main: 174358528 17:12:23 INFO - PROCESS | 22974 | 17:12:27 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40449/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:27 INFO - PROCESS | 22974 | RSS: Main: 173875200 17:12:27 INFO - PROCESS | 22974 | 17:12:30 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40449/tests/kraken/driver.html?testName=json-parse-financial) 17:12:31 INFO - PROCESS | 22974 | RSS: Main: 174567424 17:12:31 INFO - PROCESS | 22974 | 17:12:33 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40449/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:12:33 INFO - PROCESS | 22974 | RSS: Main: 184455168 17:12:33 INFO - PROCESS | 22974 | 17:12:35 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:12:36 INFO - PROCESS | 22974 | RSS: Main: 181624832 17:12:36 INFO - PROCESS | 22974 | 17:12:38 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:12:38 INFO - PROCESS | 22974 | RSS: Main: 191414272 17:12:38 INFO - PROCESS | 22974 | 17:12:41 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:12:42 INFO - PROCESS | 22974 | RSS: Main: 196358144 17:12:42 INFO - PROCESS | 22974 | 17:12:44 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:12:45 INFO - PROCESS | 22974 | RSS: Main: 195727360 17:12:45 INFO - PROCESS | 22974 | 17:12:46 INFO - PROCESS | 22974 | Cycle 1(1): loaded http://localhost:40449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40449/tests/kraken/driver.html?testName=ai-astar) 17:12:47 INFO - PROCESS | 22974 | RSS: Main: 258752512 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | __start_tp_report 17:12:47 INFO - PROCESS | 22974 | _x_x_mozilla_page_load 17:12:47 INFO - PROCESS | 22974 | _x_x_mozilla_page_load_details 17:12:47 INFO - PROCESS | 22974 | |i|pagename|runs| 17:12:47 INFO - PROCESS | 22974 | |0;ai-astar;111;113;106;111;112;111;103;112;112;111 17:12:47 INFO - PROCESS | 22974 | |1;audio-beat-detection;161;131;153;180;135;158;156;141;180;140 17:12:47 INFO - PROCESS | 22974 | |2;audio-dft;162;163;161;161;159;160;162;163;161;163 17:12:47 INFO - PROCESS | 22974 | |3;audio-fft;73;73;100;103;74;72;73;119;94;76 17:12:47 INFO - PROCESS | 22974 | |4;audio-oscillator;93;94;147;93;95;94;145;93;94;139 17:12:47 INFO - PROCESS | 22974 | |5;imaging-gaussian-blur;118;117;117;116;117;117;117;116;117;117 17:12:47 INFO - PROCESS | 22974 | |6;imaging-darkroom;146;147;146;146;147;146;147;146;146;147 17:12:47 INFO - PROCESS | 22974 | |7;imaging-desaturate;95;95;95;97;96;95;95;96;96;96 17:12:47 INFO - PROCESS | 22974 | |8;json-parse-financial;68;65;68;66;65;65;65;74;64;63 17:12:47 INFO - PROCESS | 22974 | |9;json-stringify-tinderbox;64;64;63;63;63;64;63;65;64;64 17:12:47 INFO - PROCESS | 22974 | |10;stanford-crypto-aes;81;84;84;85;83;83;82;82;84;86 17:12:47 INFO - PROCESS | 22974 | |11;stanford-crypto-ccm;125;120;124;122;128;116;117;128;118;127 17:12:47 INFO - PROCESS | 22974 | |12;stanford-crypto-pbkdf2;143;131;141;142;140;131;141;142;141;142 17:12:47 INFO - PROCESS | 22974 | |13;stanford-crypto-sha256-iterative;69;68;69;67;68;67;66;69;67;67 17:12:47 INFO - PROCESS | 22974 | __end_tp_report 17:12:47 INFO - PROCESS | 22974 | __start_cc_report 17:12:47 INFO - PROCESS | 22974 | _x_x_mozilla_cycle_collect,1194 17:12:47 INFO - PROCESS | 22974 | __end_cc_report 17:12:47 INFO - PROCESS | 22974 | __startTimestamp1459987967115__endTimestamp 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | ------- Summary: start ------- 17:12:47 INFO - PROCESS | 22974 | Number of tests: 14 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.16 (2.8%) stddev-sans-first:3.33 17:12:47 INFO - PROCESS | 22974 | Values: 111.0 113.0 106.0 111.0 112.0 111.0 103.0 112.0 112.0 111.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:157.00 stddev:17.24 (11.0%) stddev-sans-first:18.07 17:12:47 INFO - PROCESS | 22974 | Values: 161.0 131.0 153.0 180.0 135.0 158.0 156.0 141.0 180.0 140.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 17:12:47 INFO - PROCESS | 22974 | Values: 162.0 163.0 161.0 161.0 159.0 160.0 162.0 163.0 161.0 163.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#3] audio-fft Cycles:10 Average:85.70 Median:73.00 stddev:16.94 (23.2%) stddev-sans-first:17.34 17:12:47 INFO - PROCESS | 22974 | Values: 73.0 73.0 100.0 103.0 74.0 72.0 73.0 119.0 94.0 76.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.50 stddev:24.22 (25.9%) stddev-sans-first:25.01 17:12:47 INFO - PROCESS | 22974 | Values: 93.0 94.0 147.0 93.0 95.0 94.0 145.0 93.0 94.0 139.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 17:12:47 INFO - PROCESS | 22974 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:12:47 INFO - PROCESS | 22974 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 17:12:47 INFO - PROCESS | 22974 | Values: 95.0 95.0 95.0 97.0 96.0 95.0 95.0 96.0 96.0 96.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.50 stddev:3.13 (4.8%) stddev-sans-first:3.26 17:12:47 INFO - PROCESS | 22974 | Values: 68.0 65.0 68.0 66.0 65.0 65.0 65.0 74.0 64.0 63.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 17:12:47 INFO - PROCESS | 22974 | Values: 64.0 64.0 63.0 63.0 63.0 64.0 63.0 65.0 64.0 64.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:1.51 (1.8%) stddev-sans-first:1.32 17:12:47 INFO - PROCESS | 22974 | Values: 81.0 84.0 84.0 85.0 83.0 83.0 82.0 82.0 84.0 86.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:124.50 stddev:4.58 (3.7%) stddev-sans-first:4.76 17:12:47 INFO - PROCESS | 22974 | Values: 125.0 120.0 124.0 122.0 128.0 116.0 117.0 128.0 118.0 127.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.40 Median:141.50 stddev:4.50 (3.2%) stddev-sans-first:4.58 17:12:47 INFO - PROCESS | 22974 | Values: 143.0 131.0 141.0 142.0 140.0 131.0 141.0 142.0 141.0 142.0 17:12:47 INFO - PROCESS | 22974 | 17:12:47 INFO - PROCESS | 22974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 17:12:47 INFO - PROCESS | 22974 | Values: 69.0 68.0 69.0 67.0 68.0 67.0 66.0 69.0 67.0 67.0 17:12:47 INFO - PROCESS | 22974 | -------- Summary: end -------- 17:12:47 INFO - PROCESS | 22974 | 17:12:48 INFO - TEST-INFO | 22974: exit 0 17:12:48 INFO - TEST-OK | kraken | took 62279ms 17:12:48 INFO - SUITE-END | took 1180s 17:12:48 INFO - Completed test suite (00:19:40) 17:12:48 INFO - javascript benchmark 17:12:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2616.9084082057134, 2665.8267212631167, 2688.7176846431125, 2707.86460676966, 2719.374543854913, 4627.4447066352, 4710.2228132358205, 4717.29240613908, 4735.810567577293, 4794.328793968843, 4733.90532189356, 4754.120487709776, 4762.166620841347, 4771.1888978873585, 4839.4434640016325, 4298.677599180059, 4316.5036020857615, 4350.717203381786, 4379.146066517031, 4494.831343850589, 4411.6250118739945, 4412.3602077698715, 4461.063176732874, 4468.039371535119, 4484.148011877749, 4205.179989901971, 4282.336237883133, 4301.2902871026245, 4313.805878735465, 4364.10535840152, 4394.384786129945, 4396.516383197845, 4399.912001759979, 4417.3815665806815, 4462.598366147063, 4367.978160109211, 4370.060437006059, 4371.693981421302, 4391.934120988188, 4413.558644135593, 4507.3689683444345, 4557.043020965568, 4610.723356598614, 4662.393888794435, 4668.486466488684, 5013.799448022075, 5023.196288593807, 5023.924641130386, 5047.570956468705, 5065.822696205652, 5036.370453693288, 5041.143005689041, 5042.470540593222, 5045.268436076748, 5076.670016448956, 4627.9074418511445, 4666.32338310943, 4692.741899195543, 4693.530646935279, 4751.619870410359, 5207.37511498615, 5227.477252274742, 5227.529522343008, 5228.189630607262, 5256.78972841082, 4991.700497970133, 5007.173816320339, 5009.599232061426, 5021.6735912165595, 5060.797568097235, 4864.489228631013, 4930.580900623487, 4983.800647974041, 5025.773840177128, 5085.796568137233, 4972.453030166679, 4977.502249774993, 4979.526944940298, 4994.400671919393, 5036.7733451994745, 4954.677945933503, 4960.975195124073, 4963.6525443218625, 4974.030064137531, 5016.372953380827, 4127.979360103241, 4179.895502612399, 4206.936895946563, 4208.158368326347, 4208.642265407413, 3757.718171137121, 3773.283076215565, 3778.886633401002, 3790.7346485746284, 3798.2213646202463, 4340.544242854455, 4341.001569639001, 4341.804618792162, 4342.82628694855, 4343.04453020335, 5018.698878067327, 5034.622403319766, 5040.344755181803, 5073.1122053640465, 5134.589232861362, 4354.259775838115, 4363.956360436418, 4368.584984426538, 4368.825246990148, 4410.448693913261, 4386.407834942306, 4545.886352841206, 4553.704009239389, 4570.611498022706, 4598.97700511502, 4783.6651434399255, 4786.0, 4800.279958006327, 4805.543473370024, 4859.7327147005835, 5018.172001619692, 5060.443351231435, 5072.619553533574, 5085.084684756779, 5107.616928730435, 4682.157211701926, 4785.712857228577, 4790.473047964791, 4848.296996935495, 4852.344933433941, 4997.600191984705, 5013.674111182761, 5022.096022715946, 5027.3464449621315, 5039.395272567169, 5079.238114282739, 5081.745912704276, 5081.974590127025, 5089.00764350948, 5097.515736005073, 4747.501512341154, 4881.023795240895, 4907.901841963212, 4931.48219436954, 4940.629452790983, 4889.071076495455, 4906.313116163668, 4913.754312284443, 4924.539322925699, 4964.801407943786, 4835.564799168092, 4845.41854977405, 4848.539388758062, 4894.681845680162, 4909.337239472626, 4801.471838097877, 4902.583280421061, 4921.286413469955, 4975.353204083591, 4975.800967961386, 4728.101660684459, 4741.122892264942, 4748.382710247645, 4752.192127338291, 4800.279958006327], "unit": "score", "name": "dojo.html", "value": 4637.406508658776}, {"lowerIsBetter": false, "replicates": [535.3923297057838, 539.2773683264426, 562.024886821365, 564.472218475725, 575.8387651457591, 27487.175384738464, 27864.860675696593, 27908.720912790865, 27966.0, 33918.32163356731, 37069.814650926775, 37581.24837503248, 37650.4352434713, 37721.43417848735, 37760.43359349612, 7635.885461718079, 7761.844763104735, 7807.258310460497, 7807.375409967189, 7808.414368922326, 7646.847063058735, 7777.0, 7783.182765809594, 7785.805354866117, 7796.337311328544, 7785.221477852226, 8006.479578827358, 8006.6797328107095, 8017.679292828309, 8019.558924259163, 7913.802154946144, 7973.242541958504, 8002.079760827522, 8005.759827205164, 8006.519608823489, 7882.132965373804, 7976.960115199387, 7988.520688758635, 7994.120646728855, 8001.799955001114, 37028.81485592582, 37672.0, 37708.43437348442, 37761.244775104344, 37815.43276850849, 3356.7650264481495, 3421.059208717598, 3547.9113022174392, 3759.473673685686, 3856.055266459707, 30527.236819079477, 30778.0, 30801.075967721004, 30881.0, 31352.52971205411, 3478.478228265755, 3575.6960658344074, 3606.801625910574, 3721.6836568891677, 3756.3050835595504, 225965.0, 229335.0, 231067.0, 231295.0, 231593.0, 57553.0, 58250.0, 59183.112253316234, 59211.0, 59388.0, 62166.0, 62666.373336266966, 62713.0, 62714.0592891107, 62752.68623656852, 14483.913706472056, 14758.926205368904, 14789.408423662933, 14793.186374749492, 14811.407543698131, 10890.564377424815, 11215.102791776639, 11216.32702037864, 11218.0, 11226.21416500837, 19536.0, 20789.688154677693, 21017.0, 21025.68461473079, 21171.68242476364, 6321.494280457552, 7731.884021739678, 7932.127465978738, 8384.37864164704, 8614.267787238156, 899.2356496977517, 960.7213907966611, 991.1030517381781, 1027.4811220333684, 1043.7025447747355, 27409.588856167175, 27630.0, 27847.72152278492, 27897.16308510748, 28161.859190703915, 994.0, 1062.6440142552176, 1076.7469644633504, 1077.617445806743, 1079.740862193068, 14405.567832964818, 14678.339474723449, 14772.40910363595, 14837.383196180694, 14990.775138372934, 287222.0, 287564.0, 291075.0, 291080.0, 291434.0, 47521.287180692314, 48241.0, 48252.5174748255, 48261.276080858814, 48267.0, 1084.978300433987, 1224.7060705430633, 1258.7482503499336, 1274.5602767045355, 1280.8142819291152, 24490.87754561216, 25433.237002889942, 27299.590506142027, 27699.0, 27916.30209244785, 38036.619633803304, 43542.78228608837, 44364.33453498265, 44453.555464444944, 44468.55531444774, 204935.0, 206398.0, 206908.0, 207154.0, 207514.0, 35041.12397190091, 40231.0, 41244.38133427941, 41614.0, 42457.787711061246, 40437.393439099025, 40611.1877762449, 40917.59082409138, 41353.586464134976, 41684.58315416807, 32250.83874580706, 34370.0, 34810.47784283187, 34896.65103348934, 35646.82176589101, 35080.64919350876, 35363.823180883934, 35389.646103539664, 35566.46650300196, 35582.0, 33968.66031339655, 34669.47995780015, 34677.306453871286, 34696.13259668428, 35117.0, 30691.386172275983, 31629.5255571162, 32357.838210808794, 32418.513722294658, 32496.512552312208, 24872.005119795005, 24965.37586560278, 25346.493070138862, 25540.0, 25609.61585576255], "unit": "score", "name": "ext.html", "value": 17535.07127795363}, {"lowerIsBetter": false, "replicates": [341.38209840189245, 343.3836263906289, 348.4981626457899, 349.4321727193311, 349.83382893125764, 14925.552233433002, 15282.923585382072, 15825.60435989101, 15896.84103158968, 15898.52304430869, 15437.382504699826, 15687.529374118767, 15969.760453593177, 16679.915805472636, 16727.83272167278, 4914.262860570907, 4995.0509403213455, 5017.122003649365, 5040.823571175009, 5051.0150520648485, 4630.722156670594, 4946.455889852114, 4986.252062190664, 4991.475895031006, 4995.450500444967, 4928.137575924216, 4937.481564435737, 4937.679050861682, 4938.901221975559, 4939.185034469308, 4750.738709370983, 4929.901401971958, 4954.7274899880495, 4958.578520825734, 4964.156093464102, 4359.128174365108, 4370.104128653618, 4383.145286669101, 4391.363252328427, 4393.209222339978, 19088.90455547727, 19804.70292945607, 19928.900355498274, 19953.401397958085, 19961.301354452524, 1938.3118992757509, 1973.062795172296, 1982.8215460608615, 2063.1128614695676, 2307.457747429353, 12268.0, 12674.429650665743, 12729.427175777113, 12861.742765144645, 13090.672733181651, 1582.2958783341417, 1674.8660107191395, 1709.8119206887231, 1737.9659102833793, 1766.4788887278155, 61153.694231529, 61538.38461615416, 62170.0, 62362.06456903196, 62780.68609656968, 8716.302695784449, 8864.113588641085, 9100.180983711498, 9158.313126515539, 9263.397879137834, 12185.51257949672, 12247.632571022883, 12268.631941041784, 12278.631641050782, 12284.324362159989, 6982.299381327803, 7066.7173313066905, 7096.077509923677, 7218.267615772177, 7243.529170603894, 6955.547889387275, 6987.336203060701, 7067.92932070683, 7091.3972312353, 7102.751403700846, 5470.9452905471235, 5561.443855614406, 5601.439856014366, 5601.691906945157, 5631.18347839561, 1638.655882264714, 1691.8561922236747, 1699.8640108791267, 1720.8107108218087, 1743.119724539125, 860.7288704058202, 912.926965842731, 947.2138125355938, 956.5695437053354, 969.3892847506027, 15569.0, 16254.529685327125, 16256.349746010028, 16329.183540823149, 16548.255328510248, 836.2181360428019, 869.0917990699734, 900.7883147460342, 910.2217603948661, 950.273041123541, 8838.55807209637, 9489.952550237205, 9557.139857412867, 9586.568604412818, 9644.0, 290988.0, 294019.0, 295094.0, 295478.0, 386436.0, 48553.02893942101, 61699.0, 63432.36567634357, 63473.365266346744, 66077.33922660808, 889.1020069729619, 962.9662961796444, 972.1008067537499, 1022.0954455306958, 1025.410389026313, 13617.455301787817, 14590.5622831311, 14900.063577842915, 15035.849641503444, 15375.538733838002, 32377.190570235933, 33512.49731254082, 33896.49155262722, 33976.0, 34089.318213635095, 42748.0, 43344.56655433405, 43478.78260608677, 43494.0, 43992.78003609961, 7452.292032256927, 7453.142888567884, 7518.082888863305, 7561.886571701539, 7623.618819058914, 6334.746610135543, 8165.38759593021, 9553.426794392359, 10071.748206294902, 11118.388488633203, 4942.159832828356, 7644.7768357062605, 9618.605302231277, 10003.699889003341, 10654.164500779558, 8861.202491775513, 9330.253579713471, 9554.856677149988, 9554.904450955402, 9697.466639334903, 9949.950250248703, 10138.391696497938, 10236.33463824849, 10318.43248621333, 10526.894731052591, 7202.639868006683, 7314.158871729606, 7420.888686669812, 7518.173000969779, 7524.887126693214, 8727.607257673293, 10565.9471702641, 10566.894331056592, 10592.152627789912, 10708.785824283626], "unit": "score", "name": "jquery.html", "value": 7812.170675151704}, {"lowerIsBetter": false, "replicates": [1314.1655049043866, 1421.4598452588016, 1436.088084066618, 1586.1434825194397, 1749.8862573932693, 6804.183497980243, 7279.417646588274, 7471.663775130119, 7474.96262518688, 7480.3267705906455, 7256.9637151814295, 7553.924460755391, 7555.622218889047, 7560.130584982729, 7580.6209689515445, 1915.2721965653031, 1963.518937860219, 1969.9507512312164, 2240.1935303290843, 2264.0, 2147.8389120816, 2204.228520017989, 2207.547452772186, 2208.7459942106702, 2210.5799898019327, 2186.7485239197536, 2208.9116435342567, 2226.198568515333, 2226.532428190082, 2261.796438320551, 2110.725605671253, 2113.7991890770354, 2117.100232401231, 2117.4600476878372, 2121.374194612593, 2135.252661568454, 2195.6267434536007, 2197.340797760681, 2205.415564875293, 2210.425289424745, 7736.149023607399, 7783.766487005399, 7801.648925798353, 7802.570858602775, 7819.061712594468, 4669.322948172496, 4785.401824771903, 4798.424189097295, 4803.111424386465, 4809.350737650442, 2939.4415061138316, 3007.593974813394, 3033.393321335742, 3035.3929214157038, 3045.649750278702, 956.583886009588, 984.4388698441891, 993.9155171810405, 1011.1607365886297, 1018.1651046142166, 10808.945955270174, 10839.67480975572, 10852.348859068481, 10855.674329770041, 10870.565177392895, 4224.134052519226, 4232.153569286155, 4307.827686892552, 4325.9134817303475, 4362.389265502832, 9088.81822363549, 9195.448273103635, 9198.770030749285, 9200.0, 9209.585568649427, 4793.448753393404, 4820.831270905502, 4824.445188803263, 4826.734529600905, 4828.782704778223, 3791.658750712449, 4023.8994025149605, 4134.607212314885, 4365.192439398721, 4365.672574556921, 3563.3051554946537, 3576.624454432247, 3590.9281814363567, 3602.081469225383, 3680.5583330000036, 1187.9940600296943, 1189.4171855790773, 1189.7501524679742, 1191.684203686024, 1193.0455635491571, 1202.8195770634475, 1226.0436859249799, 1244.6452760963082, 1251.0179509085324, 1251.618256431779, 7109.360157585842, 7236.746713864989, 7259.382952448996, 7286.562806231643, 7325.084364454443, 444.0652426641937, 455.0466772112419, 457.3756821938097, 462.6506987224624, 467.43207003490244, 5236.659617124875, 5240.502152295526, 5244.134717771525, 5251.842444726664, 5268.420473747885, 9012.27901767857, 9102.317326200562, 9124.45253284805, 9219.07809219086, 9239.538023098952, 8885.955570222108, 8989.910100899038, 8990.505522196212, 9071.002189759121, 9102.954485227532, 7027.367536921702, 7153.749618763319, 7231.168415632164, 7248.818779530554, 7298.781036568911, 6832.385085342343, 6866.553674011173, 6873.793786186422, 6888.276730943379, 6906.654667266516, 7833.295003449717, 8258.83482330338, 8265.0, 8278.048024477263, 8378.413511054168, 8245.175482451707, 8598.183172598594, 8617.69838055665, 8639.611217495354, 8649.178328058824, 6605.669716514251, 6613.074169616161, 6662.600243985376, 6737.898931516129, 6747.359000894907, 7235.131784185932, 7249.927500724925, 7263.309985551364, 7284.927150728425, 7332.0, 6471.514636402195, 6582.901256481253, 6611.669416529058, 6702.262751097473, 6883.0, 6609.0, 6628.867422651617, 6656.600603963778, 6665.433438157811, 6765.526413151032, 6732.596044237362, 6858.965705171442, 6913.619750913748, 6913.654317284217, 6960.303969603202, 6448.709808058742, 6475.061116138039, 6487.772927947499, 6527.5430719849155, 6536.281009089092, 6512.218533775977, 6583.275839657729, 6584.308647592125, 6592.2089349276475, 6594.538382313192], "unit": "score", "name": "mootools.html", "value": 4294.0343259260335}, {"lowerIsBetter": false, "replicates": [301.64104715388686, 312.2661744899486, 316.76559346083906, 318.56356791196066, 320.20269528873115, 5281.075811732951, 5335.4664533546675, 5447.346318441782, 5458.972705136479, 5478.04134276501, 5310.0, 5352.357717073956, 5352.384475785286, 5360.973195134028, 5375.75809088591, 3911.1199980004412, 3989.8404063837556, 4112.856050038249, 4126.773027483488, 4131.194417088669, 4104.548499665035, 4113.71204015719, 4121.258173528764, 4124.463819703435, 4130.566290539495, 4080.06158583526, 4082.4896887889013, 4083.693722970774, 4084.938725919099, 4097.89755256118, 3882.3594106972314, 3927.273454410943, 4024.5371782245124, 4039.192161567669, 4045.2920738870876, 3503.5795704515367, 3505.4040813061843, 3506.719462443024, 3510.385682505577, 3518.1556426457723, 5128.051310507568, 5128.743562821881, 5148.304978827848, 5150.536451719326, 5155.175171972466, 4646.372739680134, 4674.135284972257, 4683.250679891235, 4687.20317546018, 4689.554492323224, 5602.859928501779, 5609.186667933127, 5613.382527921925, 5618.0449323615085, 5618.747156377973, 3869.9226015479535, 3872.419137129425, 3877.3408520551575, 3879.0884142226555, 3879.4180872869297, 5654.491095801398, 5891.734871930774, 5904.409559044104, 5906.055031194988, 5914.615549989237, 3968.1865217630316, 3977.8607748729232, 3993.4409182714444, 4002.2595819773437, 4006.198760247962, 4042.959570404317, 4047.3524236122666, 4050.736702114353, 4052.5339585947404, 4054.290499162694, 4660.766961651904, 4669.556392142741, 4673.859784206479, 4674.813007479731, 4682.41469816273, 5553.1670249462095, 5584.553235741131, 5586.692731899703, 5589.161625756169, 5591.161325801162, 1402.067625029344, 1418.3475601223347, 1420.6874487612708, 1421.9360128794228, 1428.271581493425, 926.8841394825647, 961.4663861556763, 974.8440249560178, 1007.5717819926502, 1011.0193112680688, 4852.902941941142, 4856.587190088882, 4862.732549709729, 4936.111499929975, 4937.333459982929, 5779.219805326311, 5781.682007489544, 5785.1611516329895, 5796.594238403271, 5798.9420105799245, 4928.802847886116, 4932.334134891816, 4938.481459446706, 4939.456659767423, 4941.925871111936, 3065.57082008519, 3107.0523490335213, 3108.347247078094, 3109.891153809606, 3110.5178697301953, 5398.865028374322, 5416.295881535454, 5440.319960004999, 5442.727863606883, 5444.455554444603, 5800.274965629296, 5918.674472903946, 5944.673042982591, 5995.790147344822, 6021.337652858269, 5485.424030476823, 5516.7517461714315, 5518.420565840529, 5519.641223320471, 5531.170324451365, 5863.560232982629, 5865.354810970704, 5870.442307980735, 5873.0, 5881.823545293477, 5734.0, 5734.455226753452, 5741.655500669973, 5746.2529871116485, 5750.137479378127, 5387.191921211849, 5519.503244707996, 5528.6406383586545, 5533.7786488540005, 5535.0, 3955.5055618047745, 4025.718199726108, 4033.495813023372, 4034.193161367797, 4034.495688038995, 5571.387147413862, 5624.6625202487985, 5810.767569297181, 5846.269216347957, 5848.0350742127075, 5555.333359996826, 5584.4136365681015, 5620.494155526022, 5625.915611265917, 5659.9151012735665, 5362.168863826113, 5462.890742185214, 5645.68948707825, 5676.801311954062, 5677.914831277451, 5570.997220500349, 5579.2746942897165, 5579.804706835242, 5584.972075139598, 5587.161925711176, 5644.604877658525, 5646.971765141148, 5656.151577263443, 5659.0, 5672.234248376416, 5557.388687244319, 5559.610827242216, 5569.415211402745, 5575.470330318613, 5576.275084239023], "unit": "score", "name": "prototype.html", "value": 4202.615449243538}, {"lowerIsBetter": false, "replicates": [670.7216505150362, 681.1077488490079, 716.6595866963191, 746.220199891114, 774.254792122971, 12525.0, 12776.68058298543, 12805.10364274501, 12805.615831525069, 12814.03894707896, 12001.039916806656, 12078.094142939293, 12083.818742718866, 12092.214006089598, 12202.755944881097, 799.2167675677839, 806.4072906413782, 813.1055838577577, 813.4712436915993, 813.9511629302232, 662.2384258103172, 790.9683612655516, 817.791463176889, 818.97133600324, 819.7540737778672, 849.0575461238021, 850.5237067242364, 851.5061264466594, 852.722865068852, 856.9828603427927, 686.5262968551683, 843.8354520868434, 844.6114787197865, 846.1369403208723, 852.2500199824146, 624.8156793745856, 632.9525285603598, 633.6926590603599, 633.8066889598671, 634.0, 12117.39413029345, 12217.144799864012, 12226.694332641755, 12298.200616959959, 12306.138570300083, 12237.326947017911, 12719.491220351174, 12886.0, 12970.092093553456, 13063.085584009123, 9941.304108712393, 9957.153641940444, 10095.899041009568, 10151.375779875185, 10162.339447935861, 3312.585926759155, 3360.630330663625, 3379.205886616643, 3507.4563442666426, 3509.0876372143425, 39649.20701585952, 40239.39640905389, 40259.7987010066, 40979.7951010246, 41121.794391028154, 8874.51190184546, 9039.276857851357, 9170.587323570455, 9219.631214751334, 9350.953245233866, 16910.915445422695, 16952.15239238058, 16999.0, 17013.31946722142, 17020.574485637957, 6427.228732552124, 6482.2869484357625, 6487.124238227873, 6516.739330426824, 6641.701123449457, 3784.4323351497496, 3785.375413056815, 3830.444585535082, 3891.610838916086, 3893.649571538575, 2832.730890565393, 2872.0665783620407, 2878.985605072003, 2890.118513853295, 2890.9710902891125, 499.84504803511027, 506.1521950732508, 518.4608007672055, 522.8666689994027, 524.2320001198262, 475.8929240920765, 552.5883217003358, 586.8356860079184, 605.577846933275, 610.5970059760625, 8213.671453141927, 8330.083690794008, 8343.624536895853, 8368.37237207212, 8465.0, 483.48750324655276, 517.3068088761003, 517.4153206876206, 551.8344496650989, 558.2909704675039, 3807.8667246646232, 3819.6753275971855, 3834.5206849143856, 3856.4793752843566, 3917.8628747993685, 53029.73485132627, 53406.0, 53469.7326513365, 53525.1971220432, 53673.731631341594, 43415.0, 44750.32874506885, 45251.32123018157, 46025.53974460279, 46308.3053754194, 42080.36879446811, 42365.152696945275, 42481.0, 42608.147837043085, 42622.78688606537, 8840.425372350777, 8910.153535414125, 8938.642454301755, 8974.102589741235, 9007.189352958265, 30564.541531876595, 31316.843415782776, 32513.0, 32636.83681581577, 32877.67122328746, 38980.0, 41369.1726165481, 41522.0, 42263.78868105763, 42427.1514569713, 10398.324108932895, 10456.315526709936, 10663.733406664895, 10725.457769630808, 10817.242793004729, 10862.619808306672, 11330.150238731963, 11358.488868000795, 11431.828522572334, 11826.82259766087, 10771.13830893511, 11225.214235003472, 11285.153613478858, 11464.31214127155, 11470.197086203885, 10828.837567436653, 11047.337159770439, 11436.942815286204, 11653.941730291293, 11691.123165762432, 10905.291156074829, 10971.396573188551, 11367.374794386387, 11465.770684586429, 11555.42222888869, 8899.599518021834, 9220.216281615869, 9529.761755956157, 9624.278179136452, 9842.901570984484, 9459.148676619137, 9542.761430964281, 9563.282753793632, 9745.22038236925, 9764.316497845082], "unit": "score", "name": "yui.html", "value": 5935.067934631569}], "name": "dromaeo_css", "value": 6389.519293060545}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 111.0, 112.0, 111.0, 103.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [161.0, 131.0, 153.0, 180.0, 135.0, 158.0, 156.0, 141.0, 180.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 153.5}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 161.0, 159.0, 160.0, 162.0, 163.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 100.0, 103.0, 74.0, 72.0, 73.0, 119.0, 94.0, 76.0], "unit": "score", "name": "audio-fft", "value": 85.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 147.0, 93.0, 95.0, 94.0, 145.0, 93.0, 94.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 68.0, 66.0, 65.0, 65.0, 65.0, 74.0, 64.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 66.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 84.0, 85.0, 83.0, 83.0, 82.0, 82.0, 84.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [125.0, 120.0, 124.0, 122.0, 128.0, 116.0, 117.0, 128.0, 118.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [143.0, 131.0, 141.0, 142.0, 140.0, 131.0, 141.0, 142.0, 141.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 67.0, 68.0, 67.0, 66.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1521.5000000000002}]} 17:12:48 INFO - Return code: 0 17:12:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:12:48 ERROR - # TBPL SUCCESS # 17:12:48 INFO - Running post-action listener: _resource_record_post_action 17:12:48 INFO - Running post-run listener: _resource_record_post_run 17:12:49 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 16384; Write bytes: 294932480; Read time: 184; Write time: 140164 17:12:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13283328; Read time: 0; Write time: 12508 17:12:49 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 16384; Write bytes: 280784896; Read time: 184; Write time: 127552 17:12:49 INFO - Running post-run listener: _upload_blobber_files 17:12:49 INFO - Blob upload gear active. 17:12:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:12:49 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 17:12:49 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'] 17:12:49 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 17:12:49 INFO - (blobuploader) - INFO - Open directory for files ... 17:12:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:12:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:12:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:50 INFO - (blobuploader) - INFO - Done attempting. 17:12:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:12:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:12:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:51 INFO - (blobuploader) - INFO - Done attempting. 17:12:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:12:51 INFO - Return code: 0 17:12:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:12:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:12:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fbaf3264223a90bcdb60a518f0f21c43e87a5f6392d87a2f7174ea9075a186593523294705974f314353f99e755f18e6a0fdd67ae3986707b5751fdda9bfbe6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c75dfaccc5c23d30a8bbf7d5024221dd62dabdbf0464f14fa5ceaeda92a5035310c9917a99876119c40b23126545b1a24ee109d8743dc089b4f0f05fe1cdeb30"} 17:12:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:12:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:12:51 INFO - Contents: 17:12:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fbaf3264223a90bcdb60a518f0f21c43e87a5f6392d87a2f7174ea9075a186593523294705974f314353f99e755f18e6a0fdd67ae3986707b5751fdda9bfbe6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c75dfaccc5c23d30a8bbf7d5024221dd62dabdbf0464f14fa5ceaeda92a5035310c9917a99876119c40b23126545b1a24ee109d8743dc089b4f0f05fe1cdeb30"} 17:12:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:12:51 INFO - Copying logs to upload dir... 17:12:51 INFO - mkdir: /builds/slave/test/build/upload/logs 17:12:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2673.766302 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 44 mins, 33 secs) (at 2016-04-06 17:12:51.431931) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 17:12:51.435630) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588 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/fbaf3264223a90bcdb60a518f0f21c43e87a5f6392d87a2f7174ea9075a186593523294705974f314353f99e755f18e6a0fdd67ae3986707b5751fdda9bfbe6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c75dfaccc5c23d30a8bbf7d5024221dd62dabdbf0464f14fa5ceaeda92a5035310c9917a99876119c40b23126545b1a24ee109d8743dc089b4f0f05fe1cdeb30"} build_url:https://queue.taskcluster.net/v1/task/MpYKDd3ZTR6DRHWexUqriQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/MpYKDd3ZTR6DRHWexUqriQ/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/fbaf3264223a90bcdb60a518f0f21c43e87a5f6392d87a2f7174ea9075a186593523294705974f314353f99e755f18e6a0fdd67ae3986707b5751fdda9bfbe6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c75dfaccc5c23d30a8bbf7d5024221dd62dabdbf0464f14fa5ceaeda92a5035310c9917a99876119c40b23126545b1a24ee109d8743dc089b4f0f05fe1cdeb30"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 17:12:51.459957) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 17:12:51.460310) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459983933.147247-2104157588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 17:12:51.546499) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 17:12:51.546811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 17:12:51.547090) ========= ========= Total master_lag: 0.26 =========