builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1458943897.16 results: success (0) buildid: 20160325140735 builduid: 81707230d6b84c5684691fcf73eea06d revision: 4a92742ac20d768b4824171b2167aee2900510bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.164110) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.164467) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.164762) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004892 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.231368) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.234664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.578461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.581775) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.678354) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.678621) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.682018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.682292) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-25 15:11:37-- 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% 98.1M=0s 2016-03-25 15:11:38 (98.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.243103 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.975764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:37.976043) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.115618 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:38.109358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:38.109724) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4a92742ac20d768b4824171b2167aee2900510bd --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 4a92742ac20d768b4824171b2167aee2900510bd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-25 15:11:38,310 truncating revision to first 12 chars 2016-03-25 15:11:38,311 Setting DEBUG logging. 2016-03-25 15:11:38,311 attempt 1/10 2016-03-25 15:11:38,311 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4a92742ac20d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 15:11:38,564 unpacking tar archive at: fx-team-4a92742ac20d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538961 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:38.662387) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:38.663174) ========= echo 4a92742ac20d768b4824171b2167aee2900510bd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4a92742ac20d768b4824171b2167aee2900510bd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4a92742ac20d768b4824171b2167aee2900510bd program finished with exit code 0 elapsedTime=0.003833 script_repo_revision: '4a92742ac20d768b4824171b2167aee2900510bd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:38.715020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:38.715325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 15:11:38.728163) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-25 15:11:38.728454) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:11:39 INFO - MultiFileLogger online at 20160325 15:11:39 in /builds/slave/test 15:11:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:11:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:11:39 INFO - {'append_to_log': False, 15:11:39 INFO - 'base_work_dir': '/builds/slave/test', 15:11:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:11:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:11:39 INFO - 'branch': 'Fx-Team-Non-PGO', 15:11:39 INFO - 'buildbot_json_path': 'buildprops.json', 15:11:39 INFO - 'config_files': ('talos/linux_config.py',), 15:11:39 INFO - 'default_actions': ('clobber', 15:11:39 INFO - 'read-buildbot-config', 15:11:39 INFO - 'download-and-extract', 15:11:39 INFO - 'populate-webroot', 15:11:39 INFO - 'create-virtualenv', 15:11:39 INFO - 'install', 15:11:39 INFO - 'run-tests'), 15:11:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:11:39 INFO - 'download_minidump_stackwalk': True, 15:11:39 INFO - 'download_symbols': 'ondemand', 15:11:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:11:39 INFO - 'tooltool.py': '/tools/tooltool.py', 15:11:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:11:39 INFO - '/tools/misc-python/virtualenv.py')}, 15:11:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:11:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:11:39 INFO - 'installer_path': 'installer.exe', 15:11:39 INFO - 'log_level': 'info', 15:11:39 INFO - 'log_name': 'talos', 15:11:39 INFO - 'log_to_console': True, 15:11:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:11:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:11:39 INFO - 'opt_config_files': (), 15:11:39 INFO - 'pip_index': False, 15:11:39 INFO - 'sps_profile': False, 15:11:39 INFO - 'sps_profile_interval': 0, 15:11:39 INFO - 'suite': 'dromaeojs', 15:11:39 INFO - 'system_bits': '32', 15:11:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:11:39 INFO - 'title': 'talos-linux64-ix-046', 15:11:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:11:39 INFO - 'use_talos_json': True, 15:11:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:11:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:11:39 INFO - 'work_dir': 'build'} 15:11:39 INFO - ##### 15:11:39 INFO - ##### Running clobber step. 15:11:39 INFO - ##### 15:11:39 INFO - Running pre-action listener: _resource_record_pre_action 15:11:39 INFO - Running main action method: clobber 15:11:39 INFO - rmtree: /builds/slave/test/build 15:11:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:11:40 INFO - Running post-action listener: _resource_record_post_action 15:11:40 INFO - ##### 15:11:40 INFO - ##### Running read-buildbot-config step. 15:11:40 INFO - ##### 15:11:40 INFO - Running pre-action listener: _resource_record_pre_action 15:11:40 INFO - Running main action method: read_buildbot_config 15:11:40 INFO - Using buildbot properties: 15:11:40 INFO - { 15:11:40 INFO - "project": "", 15:11:40 INFO - "product": "firefox", 15:11:40 INFO - "script_repo_revision": "production", 15:11:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:11:40 INFO - "repository": "", 15:11:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:11:40 INFO - "buildid": "20160325140735", 15:11:40 INFO - "pgo_build": "False", 15:11:40 INFO - "basedir": "/builds/slave/test", 15:11:40 INFO - "buildnumber": 2696, 15:11:40 INFO - "slavename": "talos-linux64-ix-046", 15:11:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:11:40 INFO - "platform": "ubuntu64_hw", 15:11:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:11:40 INFO - "branch": "fx-team", 15:11:40 INFO - "repo_path": "integration/fx-team", 15:11:40 INFO - "revision": "4a92742ac20d768b4824171b2167aee2900510bd", 15:11:40 INFO - "stage_platform": "linux64", 15:11:40 INFO - "builduid": "81707230d6b84c5684691fcf73eea06d", 15:11:40 INFO - "slavebuilddir": "test" 15:11:40 INFO - } 15:11:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:11:40 INFO - Running post-action listener: _resource_record_post_action 15:11:40 INFO - ##### 15:11:40 INFO - ##### Running download-and-extract step. 15:11:40 INFO - ##### 15:11:40 INFO - Running pre-action listener: _resource_record_pre_action 15:11:40 INFO - Running main action method: download_and_extract 15:11:40 INFO - mkdir: /builds/slave/test/build/tests 15:11: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')]} 15:11:40 INFO - https://queue.taskcluster.net/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:11:52 INFO - Downloaded 1361 bytes. 15:11:52 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:11:52 INFO - Using the following test package requirements: 15:11:52 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:11:52 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:11:52 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:11:52 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:52 INFO - u'jsshell-linux-x86_64.zip'], 15:11:52 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:11:52 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:11:52 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:11:52 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:11:52 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:11:52 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:11:52 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:52 INFO - https://queue.taskcluster.net/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:11:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:11:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:11:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:12:03 INFO - Downloaded 22085406 bytes. 15:12:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:12:04 INFO - Return code: 0 15:12:04 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:04 INFO - https://queue.taskcluster.net/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:12:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:12:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:12:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:12:06 INFO - Downloaded 22085406 bytes. 15:12:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:12:07 INFO - Return code: 0 15:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:07 INFO - https://queue.taskcluster.net/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:12:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:12:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:12:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:12:09 INFO - Downloaded 10847531 bytes. 15:12:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:12:09 INFO - Return code: 0 15:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:09 INFO - https://queue.taskcluster.net/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:12:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:12:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:12:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:12:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:12:12 INFO - Downloaded 54257965 bytes. 15:12:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:12:12 INFO - mkdir: /builds/slave/test/properties 15:12:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:12:12 INFO - Writing to file /builds/slave/test/properties/build_url 15:12:12 INFO - Contents: 15:12:12 INFO - build_url:https://queue.taskcluster.net/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:12:13 INFO - Running post-action listener: _resource_record_post_action 15:12:13 INFO - Running post-action listener: set_extra_try_arguments 15:12:13 INFO - ##### 15:12:13 INFO - ##### Running populate-webroot step. 15:12:13 INFO - ##### 15:12:13 INFO - Running pre-action listener: _resource_record_pre_action 15:12:13 INFO - Running main action method: populate_webroot 15:12:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:12:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:12:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:12:13 INFO - '--tppagecycles', 15:12:13 INFO - '7'], 15:12:13 INFO - 'tests': ['tsvgm']}}, 15:12:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:12:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:12:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:12:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:12:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:12:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:12:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:13 INFO - 'talos_options': ['--e10s'], 15:12:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:13 INFO - 'tests': ['damp', 'tps']}, 15:12:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:13 INFO - 'talos_options': ['--e10s'], 15:12:13 INFO - 'tests': ['damp', 'tps']}, 15:12:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:12:13 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 15:12:13 INFO - 'tests': ['dromaeo_dom']}, 15:12:13 INFO - 'other': {'tests': ['a11yr', 15:12:13 INFO - 'ts_paint', 15:12:13 INFO - 'tpaint', 15:12:13 INFO - 'sessionrestore', 15:12:13 INFO - 'sessionrestore_no_auto_restore', 15:12:13 INFO - 'tabpaint']}, 15:12:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:12:13 INFO - 'tests': ['a11yr', 15:12:13 INFO - 'ts_paint', 15:12:13 INFO - 'tpaint', 15:12:13 INFO - 'sessionrestore', 15:12:13 INFO - 'sessionrestore_no_auto_restore', 15:12:13 INFO - 'tabpaint']}, 15:12:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:12:13 INFO - 'tests': ['a11yr', 15:12:13 INFO - 'ts_paint', 15:12:13 INFO - 'tpaint', 15:12:13 INFO - 'sessionrestore', 15:12:13 INFO - 'sessionrestore_no_auto_restore', 15:12:13 INFO - 'tabpaint']}, 15:12:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:12:13 INFO - 'tests': ['a11yr', 15:12:13 INFO - 'ts_paint', 15:12:13 INFO - 'tpaint', 15:12:13 INFO - 'sessionrestore', 15:12:13 INFO - 'sessionrestore_no_auto_restore', 15:12:13 INFO - 'tabpaint']}, 15:12:13 INFO - 'other_l64': {'tests': ['a11yr', 15:12:13 INFO - 'ts_paint', 15:12:13 INFO - 'tpaint', 15:12:13 INFO - 'sessionrestore', 15:12:13 INFO - 'sessionrestore_no_auto_restore', 15:12:13 INFO - 'tabpaint']}, 15:12:13 INFO - 'other_nol64': {'tests': ['a11yr', 15:12:13 INFO - 'ts_paint', 15:12:13 INFO - 'tpaint', 15:12:13 INFO - 'sessionrestore', 15:12:13 INFO - 'sessionrestore_no_auto_restore', 15:12:13 INFO - 'tabpaint']}, 15:12:13 INFO - 'svgr': {'tests': ['tsvgx', 15:12:13 INFO - 'tsvgr_opacity', 15:12:13 INFO - 'tart', 15:12:13 INFO - 'tscrollx', 15:12:13 INFO - 'cart']}, 15:12:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:12:13 INFO - 'tests': ['tsvgx', 15:12:13 INFO - 'tsvgr_opacity', 15:12:13 INFO - 'tart', 15:12:13 INFO - 'tscrollx', 15:12:13 INFO - 'cart']}, 15:12:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:13 INFO - 'tests': ['tp5o']}, 15:12:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:13 INFO - 'talos_options': ['--e10s'], 15:12:13 INFO - 'tests': ['tp5o']}, 15:12:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:13 INFO - 'talos_options': ['--xperf_path', 15:12:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:13 INFO - 'tests': ['tp5n']}, 15:12:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:13 INFO - 'talos_options': ['--e10s', 15:12:13 INFO - '--xperf_path', 15:12:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:13 INFO - 'tests': ['tp5n']}}, 15:12:13 INFO - 'talos.zip': {'path': '', 15:12:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:12:13 INFO - Running post-action listener: _resource_record_post_action 15:12:13 INFO - ##### 15:12:13 INFO - ##### Running create-virtualenv step. 15:12:13 INFO - ##### 15:12:13 INFO - Running pre-action listener: _resource_record_pre_action 15:12:13 INFO - Running main action method: create_virtualenv 15:12:13 INFO - Creating virtualenv /builds/slave/test/build/venv 15:12:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:12:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:12:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:12:13 INFO - Using real prefix '/usr' 15:12:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:12:14 INFO - Installing distribute.............................................................................................................................................................................................done. 15:12:16 INFO - Installing pip.................done. 15:12:16 INFO - Return code: 0 15:12:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:16 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 0x7f3368a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29410>, '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 0x2b2a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:12:16 INFO - Using env: {'DISPLAY': ':0', 15:12:16 INFO - 'HOME': '/home/cltbld', 15:12:16 INFO - 'LANG': 'en_US.UTF-8', 15:12:16 INFO - 'LANGUAGE': 'en_US:en', 15:12:16 INFO - 'LOGNAME': 'cltbld', 15:12:16 INFO - 'MAIL': '/var/mail/cltbld', 15:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:16 INFO - 'MOZ_NO_REMOTE': '1', 15:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:16 INFO - 'NO_EM_RESTART': '1', 15:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:16 INFO - 'PWD': '/builds/slave/test', 15:12:16 INFO - 'SHELL': '/bin/bash', 15:12:16 INFO - 'SHLVL': '1', 15:12:16 INFO - 'TERM': 'linux', 15:12:16 INFO - 'TMOUT': '86400', 15:12:16 INFO - 'USER': 'cltbld', 15:12:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 15:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:16 INFO - '_': '/tools/buildbot/bin/python'} 15:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:12:16 INFO - Cleaning up... 15:12:16 INFO - Return code: 0 15:12:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:16 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 0x7f3368a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29410>, '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 0x2b2a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:12:16 INFO - Using env: {'DISPLAY': ':0', 15:12:16 INFO - 'HOME': '/home/cltbld', 15:12:16 INFO - 'LANG': 'en_US.UTF-8', 15:12:16 INFO - 'LANGUAGE': 'en_US:en', 15:12:16 INFO - 'LOGNAME': 'cltbld', 15:12:16 INFO - 'MAIL': '/var/mail/cltbld', 15:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:16 INFO - 'MOZ_NO_REMOTE': '1', 15:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:16 INFO - 'NO_EM_RESTART': '1', 15:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:16 INFO - 'PWD': '/builds/slave/test', 15:12:16 INFO - 'SHELL': '/bin/bash', 15:12:16 INFO - 'SHLVL': '1', 15:12:16 INFO - 'TERM': 'linux', 15:12:16 INFO - 'TMOUT': '86400', 15:12:16 INFO - 'USER': 'cltbld', 15:12:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 15:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:16 INFO - '_': '/tools/buildbot/bin/python'} 15:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:16 INFO - Downloading/unpacking psutil>=0.7.1 15:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:12:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:19 INFO - Installing collected packages: psutil 15:12:19 INFO - Running setup.py install for psutil 15:12:19 INFO - building 'psutil._psutil_linux' extension 15:12:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:12:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:12:20 INFO - building 'psutil._psutil_posix' extension 15:12:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:12:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:12:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:20 INFO - Successfully installed psutil 15:12:20 INFO - Cleaning up... 15:12:20 INFO - Return code: 0 15:12:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3368a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29410>, '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 0x2b2a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:12:20 INFO - Using env: {'DISPLAY': ':0', 15:12:20 INFO - 'HOME': '/home/cltbld', 15:12:20 INFO - 'LANG': 'en_US.UTF-8', 15:12:20 INFO - 'LANGUAGE': 'en_US:en', 15:12:20 INFO - 'LOGNAME': 'cltbld', 15:12:20 INFO - 'MAIL': '/var/mail/cltbld', 15:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:20 INFO - 'MOZ_NO_REMOTE': '1', 15:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:20 INFO - 'NO_EM_RESTART': '1', 15:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:20 INFO - 'PWD': '/builds/slave/test', 15:12:20 INFO - 'SHELL': '/bin/bash', 15:12:20 INFO - 'SHLVL': '1', 15:12:20 INFO - 'TERM': 'linux', 15:12:20 INFO - 'TMOUT': '86400', 15:12:20 INFO - 'USER': 'cltbld', 15:12:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 15:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:20 INFO - '_': '/tools/buildbot/bin/python'} 15:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:12:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:12:22 INFO - Installing collected packages: mozsystemmonitor 15:12:22 INFO - Running setup.py install for mozsystemmonitor 15:12:23 INFO - Successfully installed mozsystemmonitor 15:12:23 INFO - Cleaning up... 15:12:23 INFO - Return code: 0 15:12:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3368a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29410>, '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 0x2b2a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:12:23 INFO - Using env: {'DISPLAY': ':0', 15:12:23 INFO - 'HOME': '/home/cltbld', 15:12:23 INFO - 'LANG': 'en_US.UTF-8', 15:12:23 INFO - 'LANGUAGE': 'en_US:en', 15:12:23 INFO - 'LOGNAME': 'cltbld', 15:12:23 INFO - 'MAIL': '/var/mail/cltbld', 15:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:23 INFO - 'MOZ_NO_REMOTE': '1', 15:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:23 INFO - 'NO_EM_RESTART': '1', 15:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:23 INFO - 'PWD': '/builds/slave/test', 15:12:23 INFO - 'SHELL': '/bin/bash', 15:12:23 INFO - 'SHLVL': '1', 15:12:23 INFO - 'TERM': 'linux', 15:12:23 INFO - 'TMOUT': '86400', 15:12:23 INFO - 'USER': 'cltbld', 15:12:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 15:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:23 INFO - '_': '/tools/buildbot/bin/python'} 15:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:23 INFO - Downloading/unpacking blobuploader==1.2.4 15:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:12:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:12:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:25 INFO - Downloading docopt-0.6.1.tar.gz 15:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:12:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:12:25 INFO - Running setup.py install for blobuploader 15:12:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:12:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:12:25 INFO - Running setup.py install for requests 15:12:26 INFO - Running setup.py install for docopt 15:12:26 INFO - Successfully installed blobuploader requests docopt 15:12:26 INFO - Cleaning up... 15:12:26 INFO - Return code: 0 15:12:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:26 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 0x7f3368a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29410>, '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 0x2b2a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:12:26 INFO - Using env: {'DISPLAY': ':0', 15:12:26 INFO - 'HOME': '/home/cltbld', 15:12:26 INFO - 'LANG': 'en_US.UTF-8', 15:12:26 INFO - 'LANGUAGE': 'en_US:en', 15:12:26 INFO - 'LOGNAME': 'cltbld', 15:12:26 INFO - 'MAIL': '/var/mail/cltbld', 15:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:26 INFO - 'MOZ_NO_REMOTE': '1', 15:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:26 INFO - 'NO_EM_RESTART': '1', 15:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:26 INFO - 'PWD': '/builds/slave/test', 15:12:26 INFO - 'SHELL': '/bin/bash', 15:12:26 INFO - 'SHLVL': '1', 15:12:26 INFO - 'TERM': 'linux', 15:12:26 INFO - 'TMOUT': '86400', 15:12:26 INFO - 'USER': 'cltbld', 15:12:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 15:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:26 INFO - '_': '/tools/buildbot/bin/python'} 15:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:26 INFO - Running setup.py (path:/tmp/pip-JLvuBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:26 INFO - Running setup.py (path:/tmp/pip-ILD7Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:26 INFO - Running setup.py (path:/tmp/pip-p8pZqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:26 INFO - Running setup.py (path:/tmp/pip-XR_09t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:26 INFO - Running setup.py (path:/tmp/pip-mDtvFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:27 INFO - Running setup.py (path:/tmp/pip-zUmWns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:27 INFO - Running setup.py (path:/tmp/pip-gejIrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:27 INFO - Running setup.py (path:/tmp/pip-glpVdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:27 INFO - Running setup.py (path:/tmp/pip-KNkGi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:27 INFO - Running setup.py (path:/tmp/pip-YOP8sO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:27 INFO - Running setup.py (path:/tmp/pip-9u26TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:27 INFO - Running setup.py (path:/tmp/pip-zTBfQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:27 INFO - Running setup.py (path:/tmp/pip-2wOT1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:27 INFO - Running setup.py (path:/tmp/pip-al0LdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:27 INFO - Running setup.py (path:/tmp/pip-GTNYFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:27 INFO - Running setup.py (path:/tmp/pip-e1SVcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:27 INFO - Running setup.py (path:/tmp/pip-RhVWvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:12:27 INFO - Running setup.py install for manifestparser 15:12:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:12:28 INFO - Running setup.py install for mozcrash 15:12:28 INFO - Running setup.py install for mozdebug 15:12:28 INFO - Running setup.py install for mozdevice 15:12:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:12:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:12:28 INFO - Running setup.py install for mozfile 15:12:28 INFO - Running setup.py install for mozhttpd 15:12:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:12:28 INFO - Running setup.py install for mozinfo 15:12:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:12:28 INFO - Running setup.py install for mozInstall 15:12:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:12:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:12:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:12:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:12:28 INFO - Running setup.py install for mozleak 15:12:28 INFO - Running setup.py install for mozlog 15:12:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:12:28 INFO - Running setup.py install for moznetwork 15:12:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:12:29 INFO - Running setup.py install for mozprocess 15:12:29 INFO - Running setup.py install for mozprofile 15:12:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:12:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:12:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:12:29 INFO - Running setup.py install for mozrunner 15:12:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:12:29 INFO - Running setup.py install for mozscreenshot 15:12:29 INFO - Running setup.py install for moztest 15:12:29 INFO - Running setup.py install for mozversion 15:12:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:12:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:12:29 INFO - Cleaning up... 15:12:29 INFO - Return code: 0 15:12:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:29 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 0x7f3368a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29410>, '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 0x2b2a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:12:29 INFO - Using env: {'DISPLAY': ':0', 15:12:29 INFO - 'HOME': '/home/cltbld', 15:12:29 INFO - 'LANG': 'en_US.UTF-8', 15:12:29 INFO - 'LANGUAGE': 'en_US:en', 15:12:29 INFO - 'LOGNAME': 'cltbld', 15:12:29 INFO - 'MAIL': '/var/mail/cltbld', 15:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:29 INFO - 'MOZ_NO_REMOTE': '1', 15:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:29 INFO - 'NO_EM_RESTART': '1', 15:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:29 INFO - 'PWD': '/builds/slave/test', 15:12:29 INFO - 'SHELL': '/bin/bash', 15:12:29 INFO - 'SHLVL': '1', 15:12:29 INFO - 'TERM': 'linux', 15:12:29 INFO - 'TMOUT': '86400', 15:12:29 INFO - 'USER': 'cltbld', 15:12:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 15:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:29 INFO - '_': '/tools/buildbot/bin/python'} 15:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:29 INFO - Running setup.py (path:/tmp/pip-gQ0DZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:29 INFO - Running setup.py (path:/tmp/pip-ikmAA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:30 INFO - Running setup.py (path:/tmp/pip-bFACdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:30 INFO - Running setup.py (path:/tmp/pip-SJIcmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:30 INFO - Running setup.py (path:/tmp/pip-aIE7Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:30 INFO - Running setup.py (path:/tmp/pip-1x6b95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:30 INFO - Running setup.py (path:/tmp/pip-6JaSv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:30 INFO - Running setup.py (path:/tmp/pip-fCjd5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:30 INFO - Running setup.py (path:/tmp/pip-tFxsOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:30 INFO - Running setup.py (path:/tmp/pip-wW5dfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:30 INFO - Running setup.py (path:/tmp/pip-91oekz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:30 INFO - Running setup.py (path:/tmp/pip-QOQTEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:30 INFO - Running setup.py (path:/tmp/pip-laCNh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:30 INFO - Running setup.py (path:/tmp/pip-OSLJHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:30 INFO - Running setup.py (path:/tmp/pip-tdEYLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:31 INFO - Running setup.py (path:/tmp/pip-FwdGce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:31 INFO - Running setup.py (path:/tmp/pip-WNiXgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:33 INFO - Downloading blessings-1.6.tar.gz 15:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:12:33 INFO - Installing collected packages: blessings 15:12:33 INFO - Running setup.py install for blessings 15:12:33 INFO - Successfully installed blessings 15:12:33 INFO - Cleaning up... 15:12:33 INFO - Return code: 0 15:12:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:33 INFO - Reading from file tmpfile_stdout 15:12:33 INFO - Current package versions: 15:12:33 INFO - argparse == 1.2.1 15:12:33 INFO - blessings == 1.6 15:12:33 INFO - blobuploader == 1.2.4 15:12:33 INFO - docopt == 0.6.1 15:12:33 INFO - manifestparser == 1.1 15:12:33 INFO - mozInstall == 1.12 15:12:33 INFO - mozcrash == 0.17 15:12:33 INFO - mozdebug == 0.1 15:12:33 INFO - mozdevice == 0.48 15:12:33 INFO - mozfile == 1.2 15:12:33 INFO - mozhttpd == 0.7 15:12:33 INFO - mozinfo == 0.9 15:12:33 INFO - mozleak == 0.1 15:12:33 INFO - mozlog == 3.1 15:12:33 INFO - moznetwork == 0.27 15:12:33 INFO - mozprocess == 0.22 15:12:33 INFO - mozprofile == 0.28 15:12:33 INFO - mozrunner == 6.11 15:12:33 INFO - mozscreenshot == 0.1 15:12:33 INFO - mozsystemmonitor == 0.0 15:12:33 INFO - moztest == 0.7 15:12:33 INFO - mozversion == 1.4 15:12:33 INFO - psutil == 3.1.1 15:12:33 INFO - requests == 1.2.3 15:12:33 INFO - wsgiref == 0.1.2 15:12:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:33 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 0x7f3368a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29410>, '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 0x2b2a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:12:33 INFO - Using env: {'DISPLAY': ':0', 15:12:33 INFO - 'HOME': '/home/cltbld', 15:12:33 INFO - 'LANG': 'en_US.UTF-8', 15:12:33 INFO - 'LANGUAGE': 'en_US:en', 15:12:33 INFO - 'LOGNAME': 'cltbld', 15:12:33 INFO - 'MAIL': '/var/mail/cltbld', 15:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:33 INFO - 'MOZ_NO_REMOTE': '1', 15:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:33 INFO - 'NO_EM_RESTART': '1', 15:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:33 INFO - 'PWD': '/builds/slave/test', 15:12:33 INFO - 'SHELL': '/bin/bash', 15:12:33 INFO - 'SHLVL': '1', 15:12:33 INFO - 'TERM': 'linux', 15:12:33 INFO - 'TMOUT': '86400', 15:12:33 INFO - 'USER': 'cltbld', 15:12:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 15:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:33 INFO - '_': '/tools/buildbot/bin/python'} 15:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:12:33 INFO - Cleaning up... 15:12:33 INFO - Return code: 0 15:12:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3368a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29410>, '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 0x2b2a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12: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', 'jsonschema'] in /builds/slave/test/build 15:12: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 jsonschema 15:12:33 INFO - Using env: {'DISPLAY': ':0', 15:12:33 INFO - 'HOME': '/home/cltbld', 15:12:33 INFO - 'LANG': 'en_US.UTF-8', 15:12:33 INFO - 'LANGUAGE': 'en_US:en', 15:12:33 INFO - 'LOGNAME': 'cltbld', 15:12:33 INFO - 'MAIL': '/var/mail/cltbld', 15:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:33 INFO - 'MOZ_NO_REMOTE': '1', 15:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:33 INFO - 'NO_EM_RESTART': '1', 15:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:33 INFO - 'PWD': '/builds/slave/test', 15:12:33 INFO - 'SHELL': '/bin/bash', 15:12:33 INFO - 'SHLVL': '1', 15:12:33 INFO - 'TERM': 'linux', 15:12:33 INFO - 'TMOUT': '86400', 15:12:33 INFO - 'USER': 'cltbld', 15:12:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 15:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:33 INFO - '_': '/tools/buildbot/bin/python'} 15:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:34 INFO - Downloading/unpacking jsonschema 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:12:35 INFO - Downloading/unpacking functools32 (from jsonschema) 15:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:36 INFO - Downloading functools32-3.2.3-2.tar.gz 15:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:12:36 INFO - warning: no files found matching '*.txt' 15:12:36 INFO - no previously-included directories found matching 'build' 15:12:36 INFO - no previously-included directories found matching 'dist' 15:12:36 INFO - no previously-included directories found matching '.git*' 15:12:36 INFO - Installing collected packages: jsonschema, functools32 15:12:36 INFO - Running setup.py install for functools32 15:12:36 INFO - warning: no files found matching '*.txt' 15:12:36 INFO - no previously-included directories found matching 'build' 15:12:36 INFO - no previously-included directories found matching 'dist' 15:12:36 INFO - no previously-included directories found matching '.git*' 15:12:36 INFO - Successfully installed jsonschema functools32 15:12:36 INFO - Cleaning up... 15:12:36 INFO - Return code: 0 15:12:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:36 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 0x7f3368a3af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29410>, '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 0x2b2a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:12:36 INFO - Using env: {'DISPLAY': ':0', 15:12:36 INFO - 'HOME': '/home/cltbld', 15:12:36 INFO - 'LANG': 'en_US.UTF-8', 15:12:36 INFO - 'LANGUAGE': 'en_US:en', 15:12:36 INFO - 'LOGNAME': 'cltbld', 15:12:36 INFO - 'MAIL': '/var/mail/cltbld', 15:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:36 INFO - 'MOZ_NO_REMOTE': '1', 15:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:36 INFO - 'NO_EM_RESTART': '1', 15:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:36 INFO - 'PWD': '/builds/slave/test', 15:12:36 INFO - 'SHELL': '/bin/bash', 15:12:36 INFO - 'SHLVL': '1', 15:12:36 INFO - 'TERM': 'linux', 15:12:36 INFO - 'TMOUT': '86400', 15:12:36 INFO - 'USER': 'cltbld', 15:12:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 15:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:36 INFO - '_': '/tools/buildbot/bin/python'} 15:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:36 INFO - Downloading/unpacking flake8 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:12:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:12:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:12:39 INFO - no previously-included directories found matching 'docs/_build' 15:12:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:12:39 INFO - Running setup.py install for pep8 15:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:12:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:12:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:12:39 INFO - no previously-included directories found matching 'docs/_build' 15:12:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:12:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:12:39 INFO - Cleaning up... 15:12:39 INFO - Return code: 0 15:12:39 INFO - Running post-action listener: _resource_record_post_action 15:12:39 INFO - Running post-action listener: _start_resource_monitoring 15:12:39 INFO - Starting resource monitoring. 15:12:39 INFO - ##### 15:12:39 INFO - ##### Running install step. 15:12:39 INFO - ##### 15:12:39 INFO - Running pre-action listener: _resource_record_pre_action 15:12:39 INFO - Running main action method: install 15:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:39 INFO - Reading from file tmpfile_stdout 15:12:39 INFO - Detecting whether we're running mozinstall >=1.0... 15:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:12:39 INFO - Reading from file tmpfile_stdout 15:12:39 INFO - Output received: 15:12:39 INFO - Usage: mozinstall [options] installer 15:12:39 INFO - Options: 15:12:39 INFO - -h, --help show this help message and exit 15:12:39 INFO - -d DEST, --destination=DEST 15:12:39 INFO - Directory to install application into. [default: 15:12:39 INFO - "/builds/slave/test"] 15:12:39 INFO - --app=APP Application being installed. [default: firefox] 15:12:39 INFO - mkdir: /builds/slave/test/build/application 15:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:12:55 INFO - Reading from file tmpfile_stdout 15:12:55 INFO - Output received: 15:12:55 INFO - /builds/slave/test/build/application/firefox/firefox 15:12:55 INFO - Running post-action listener: _resource_record_post_action 15:12:55 INFO - ##### 15:12:55 INFO - ##### Running run-tests step. 15:12:55 INFO - ##### 15:12:55 INFO - Running pre-action listener: _resource_record_pre_action 15:12:55 INFO - Running main action method: run_tests 15:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:12:55 INFO - Python 2.7.3 15:12:55 INFO - Return code: 0 15:12:55 INFO - grabbing minidump binary from tooltool 15:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:55 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 0x2b29410>, '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 0x2b2a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:12:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:12:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:12:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:12:55 INFO - Return code: 0 15:12:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:12:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:12:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:12:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:12:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:12:56 INFO - Return code: 0 15:12:56 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/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:12:56 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/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:12:56 INFO - Using env: {'DISPLAY': ':0', 15:12:56 INFO - 'HOME': '/home/cltbld', 15:12:56 INFO - 'LANG': 'en_US.UTF-8', 15:12:56 INFO - 'LANGUAGE': 'en_US:en', 15:12:56 INFO - 'LOGNAME': 'cltbld', 15:12:56 INFO - 'MAIL': '/var/mail/cltbld', 15:12:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:12:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:56 INFO - 'MOZ_NO_REMOTE': '1', 15:12:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:56 INFO - 'NO_EM_RESTART': '1', 15:12:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:56 INFO - 'PWD': '/builds/slave/test', 15:12:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:12:56 INFO - 'SHELL': '/bin/bash', 15:12:56 INFO - 'SHLVL': '1', 15:12:56 INFO - 'TERM': 'linux', 15:12:56 INFO - 'TMOUT': '86400', 15:12:56 INFO - 'USER': 'cltbld', 15:12:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852', 15:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:56 INFO - '_': '/tools/buildbot/bin/python'} 15:12:56 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/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:12:56 INFO - mozversion application_buildid: 20160325140735 15:12:56 INFO - mozversion application_changeset: 4a92742ac20d768b4824171b2167aee2900510bd 15:12:56 INFO - mozversion application_display_name: Nightly 15:12:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:12:56 INFO - mozversion application_name: Firefox 15:12:56 INFO - mozversion application_remotingname: firefox 15:12:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:12:56 INFO - mozversion application_vendor: Mozilla 15:12:56 INFO - mozversion application_version: 48.0a1 15:12:56 INFO - mozversion platform_buildid: 20160325140735 15:12:56 INFO - mozversion platform_changeset: 4a92742ac20d768b4824171b2167aee2900510bd 15:12:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:12:56 INFO - mozversion platform_version: 48.0a1 15:12:56 INFO - using testdate: 1458943976 15:12:56 INFO - actual date: 1458943976 15:12:56 INFO - starting webserver on 'localhost:60907' 15:12:56 INFO - SUITE-START | Running 2 tests 15:12:56 INFO - TEST-START | dromaeo_css 15:12:56 INFO - operating with platform_type : linux_ 15:12:56 INFO - Initialising browser for dromaeo_css test... 15:12:56 INFO - TEST-INFO | started process 3306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJPJqmE/profile http://localhost:60907/getInfo.html) 15:13:03 INFO - PROCESS | 3306 | __metrics Screen width/height:1600/1200 15:13:03 INFO - PROCESS | 3306 | colorDepth:24 15:13:03 INFO - PROCESS | 3306 | Browser inner width/height: 1024/697 15:13:03 INFO - PROCESS | 3306 | __metrics 15:13:04 ERROR - PROCESS | 3306 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:13:04 INFO - PROCESS | 3306 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 15:13:05 INFO - TEST-INFO | 3306: exit 0 15:13:05 INFO - Browser initialized. 15:13:05 INFO - Running cycle 1/1 for dromaeo_css test... 15:13:05 INFO - TEST-INFO | started process 3404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJPJqmE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:17 INFO - PROCESS | 3404 | RSS: Main: 154607616 15:13:17 INFO - PROCESS | 3404 | 15:14:08 INFO - PROCESS | 3404 | 1458944048144 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:16:19 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:60907/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60907/tests/dromaeo/cssquery-ext.html) 15:16:20 INFO - PROCESS | 3404 | RSS: Main: 240807936 15:16:20 INFO - PROCESS | 3404 | 15:19:22 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:60907/tests/dromaeo/cssquery-ext.html (next: http://localhost:60907/tests/dromaeo/cssquery-jquery.html) 15:19:23 INFO - PROCESS | 3404 | RSS: Main: 234446848 15:19:23 INFO - PROCESS | 3404 | 15:22:25 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:60907/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60907/tests/dromaeo/cssquery-mootools.html) 15:22:25 INFO - PROCESS | 3404 | RSS: Main: 236871680 15:22:25 INFO - PROCESS | 3404 | 15:25:27 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:60907/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60907/tests/dromaeo/cssquery-prototype.html) 15:25:28 INFO - PROCESS | 3404 | RSS: Main: 207302656 15:25:28 INFO - PROCESS | 3404 | 15:28:31 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:60907/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60907/tests/dromaeo/cssquery-yui.html) 15:28:31 INFO - PROCESS | 3404 | RSS: Main: 220844032 15:28:31 INFO - PROCESS | 3404 | 15:31:34 INFO - PROCESS | 3404 | Cycle 1(1): loaded http://localhost:60907/tests/dromaeo/cssquery-yui.html (next: http://localhost:60907/tests/dromaeo/cssquery-dojo.html) 15:31:34 INFO - PROCESS | 3404 | RSS: Main: 319934464 15:31:34 INFO - PROCESS | 3404 | 15:31:34 INFO - PROCESS | 3404 | __start_tp_report 15:31:34 INFO - PROCESS | 3404 | _x_x_mozilla_page_load 15:31:34 INFO - PROCESS | 3404 | _x_x_mozilla_page_load_details 15:31:34 INFO - PROCESS | 3404 | |i|pagename|runs| 15:31:34 INFO - PROCESS | 3404 | |0;dojo.html;2627.9605805912915;2635.828671136376;2636.9604455933154;2645.4709058188355;2659.9335016624586;4617.353570500124;4620.122176786413;4651.906961860761;4654.930176047358;4663.207254766689;4651.511591282917;4659.790309436075;4684;4722.38608980832;4729.668923175379;4258.936115958263;4279.957200427994;4305.892352691192;4336.891577710567;4447.177272204653;4366.868993930171;4396.20868243716;4413.293872980324;4425.712328698641;4455.331700244957;4168.270552653274;4250.149970006011;4258.361245813153;4318.52496225415;4324.956750432487;4280.807363668642;4313.82744690212;4315.395844581761;4354.7604881731495;4356.607905288539;4188.183304255671;4280.37934499499;4284.464441944757;4299.247631664478;4343.478782546114;4516.661250406232;4527.750973696446;4527.864164075083;4547.226971414867;4600.953990460086;4939.086269040203;4940.827071052496;4954.281629163751;4968.105740966625;4976.925346119811;4909.607231421478;4991.777014631402;5003.824866129705;5009.922866583665;5024.321716568253;4685.437747470325;4691.132140554008;4701.553352431513;4716.481187069419;4734.360861283717;5097.643164978416;5100.056489549445;5101.591872650179;5106.183010718267;5154.5103215194495;4810.302506136661;4894.681845680019;4899.240617704261;4922.926156107661;4992.450830408652;4973.651844370859;4997.625178111656;4998.700077995332;5000.62495312853;5028.2457631354855;4945.579625731853;4946.332245146931;4959.0329885671945;4962.330085438492;5001.299818025479;4849.4908034656555;4947.851564453073;4983.6013118950395;5001.224810154432;5024.296598476216;4267.594578515036;4273.401723758676;4278.44380230568;4282.957170428318;4296.312589985588;3716.5168528091176;3728.8322025508373;3734.7012239020814;3741.663250307431;3754.887353379403;4164.292070348048;4220.746755194698;4246.278132717445;4298.333758267411;4314.935275970863;5027.170516864677;5032.119379108714;5047.97476012625;5054.469280725544;5055.090083784954;4343.305071188594;4344.695871289043;4353.934690979638;4365.148795984816;4399.934000989988;4345.413369195181;4524.8416305429155;4537.115262523842;4560.908781824345;4566.8173273068705;4761.619070474423;4769.618430525549;4784.282357646381;4794.424669039738;4844.15227335222;5046.621503387188;5047.4952504749235;5052.873678158076;5064.29099926018;5112.258722485293;4689.155951928686;4783.95216047835;4786.569208771228;4819.879503012453;4837.927431088466;4873.1959226727195;4886.926696099633;4895.73073480962;4913.606911447004;4962.131626965194;4884.584810291165;4977.178765503796;4994.51615624734;4998.075356059141;5036.194208926554;4846.781894814812;4854.17479028559;4868.878278043077;4893.192623217129;4895.755212239445;4710.199266124836;4737.976310118427;4739.21802902531;4742.928856067093;4795.904081918412;4650.883727906829;4670.743109129031;4720.362751028567;4729.858104256878;4757.714537127784;4867.853964381075;4882.707037577757;4889.437714662717;4904.313396124474;4932;4770.045990801923;4777.4267087949665;4782.689125206851;4786.95213047865;4836.661433699607 15:31:34 INFO - PROCESS | 3404 | |1;ext.html;563.9633423827454;566.3204155013983;577.0478710128291;579.0677010013877;584.748637914862;26993.460130797397;27575;34390.48414273785;34670.65329346706;34891.65108348916;37927.431088533696;38019.809900950524;38280.425793613045;38394.616053839454;38398.232035359346;7494.175640679521;7677.731279405222;7678.42411819113;7680.116786569532;7682.0397450318715;7512;7672;7678.117016543085;7685.385169186452;7690.384769218449;7672.616369181546;7748.263914928073;7895.486793358442;7913.643886025114;7928.762137135866;7767.572783496906;7791.922080779176;7812;7839.764807055797;7855;7761.45669803114;7881.448298619099;7885.053793544754;7888.329491993188;7889.368850492005;36710;37527.8123609383;37607.811960940024;37636.24727505462;37685.24629507394;3124.1877111951057;3201.631812341587;3225.70968612826;3608.206194637202;3917.5886531914025;27921.301967450774;28260.93446783106;28324.433511329866;28347;28906.27734306638;3482;3506.594105029001;3521.5950165731015;3569.303985722785;3649.087728067983;221784;222977;223352.88323558442;223563;223655;51823.22265166025;52877.471225287256;52882;52888;52916.73541632267;61312;62298;62337.376626234065;62343;62375.68812156001;14125.081869678643;14393.712125757636;14416.567502974927;14437.783433248509;14447.060941038799;10769.192310576738;10828.78342433147;10860.348379097279;10861.565537378574;10864.402457864893;19791;19846.305379311656;19935.401937941886;20021.399358019284;20114.597708045756;7099.574025558483;7726.729564465217;7783.299503044753;7851.450398472166;7853.842923141505;835.6364981233183;871.6687658689784;957.899420560845;1005.969820905374;1022.320157095538;25873;26580.734192658212;27046;27283.727162728515;27327.590086148724;864.4726716702806;998.3510718033336;999.2256001598819;1024.948752562369;1040.6513817870946;12640.040793676995;13106.541271055657;13109.082364234411;13169.407376668072;13239.867601324057;278533;284292;285318;286101;287843;45280;45895.541044589794;45948.310775338396;45968.54031459709;45982.99999999933;1044.5090807320548;1126.3692332293779;1215.914885957992;1259.3199672176922;1314.4150852870573;25315.62026569566;26875.193744187705;26950.59574106429;27176.592351115145;27236.591451128646;35239.82380088083;35479.82260088683;36159.27681446409;36164.819175903955;36199.63800362068;168864;177585.1120744388;179063.10468447575;179227;179333;26815.463690726465;27258;30078.24804379908;30538.847305763327;30930.69069309278;34500.30999380049;34508.65491345055;35221.47167792434;35415.64584354227;35571.82214088913;29826.403471930873;30258.54612180775;31407.37185256328;32714.83642581867;33507.66492335046;31512.212194695316;32511.349773003934;32587.34825303433;32816.671833282315;32989.26816589064;33337.666623333454;33384;33809;33831;33872.830635846665;27442;30111.69888301089;30311.393772123993;30319.393612128075;30471.542926855673;23479.41301467477;23786.762132378455;23969;24111.879440602686;24177.395565111012 15:31:34 INFO - PROCESS | 3404 | |2;jquery.html;340.2803071503769;344.30622296073415;347.156409923885;361.878770611845;365.55950080153417;14531.418743250257;15166.62083447913;15844.207789610517;15849.762253566178;15856.36574537017;16016;16188.433404830834;17073.658526829455;17601.295948162056;17759.28962841485;5458.645188062783;5544.833654990357;5620.718964051802;5637.633553819009;5654.321481422235;5362.410134885159;5486.698231597261;5507;5524.171374293848;5527.640703354289;5508.669479831203;5509.121955603486;5561.165825126243;5566.332040155187;5664.631798933076;5494.2857428534235;5637;5637.267155269829;5688.772449102031;5696.11710184922;5454.318210223722;5478.397376288605;5487.780488780444;5489.533389661883;5937.52499800015;20952.16191352344;21209.787902120937;21245.5750884983;21374.893125534272;22853.20013799509;2060.721802556651;2107.662773956175;2217.3569664797187;2385.522895420923;2542.3517003164075;13249.13880597758;13775.104618199784;13922.860771392257;14014.71970560583;14787.482438114723;1890.2627975089727;1914.731937528747;1935.2742721479444;1935.77738560066;1947.0362170725439;65902;69203.30796692018;69284.3071569288;69445.3055469444;70164.94752578766;14592.197429141286;14789.968056548381;14866.554003379915;14968.92515537437;15163.237969571492;24320.87839560791;24460;24517.141900033414;24633.753662463147;24707.876460617943;7968.641411136513;7997.440179187517;8340.749777506684;8423.410361274775;8436.873446898302;6994.160700715946;7103.751368702071;7114.750983715545;7160.069191005136;7203.747868824566;7375.594342311224;7542.886856697154;7577.507462014952;7621.275978782007;7643.9617801911745;2899.9710002900124;2919.664238612544;2936.1665992317517;2972.806767560102;3137.419577378192;389.3458988898621;800.5676934455445;854.8162145138825;893.6157452295575;915.9908400916039;9792.755181120529;10055.899441005642;10066.194704423628;10118.392896426238;10495.317804342692;414.54814252464956;420.27922113574755;428.5114968935416;438.1849759447425;443.6805500039966;5468.453154684579;5494.862628434241;5581.162825576196;5699.601027928005;5712.057510510802;393278;394467;402839;410852;412105;68967;70944.64527677432;71199;71416.28583714097;71632;440.82367053178984;445.99777001114785;447.05447977527945;449.49207395642713;450.1739308369179;9347.953260233655;9398.436093834393;9468.526573671426;9633.229341652792;9776;28536.429271414872;30521;30949.381012380076;31288.687113128577;31630.36739265248;42678.14643707171;44656;46509.76745116253;46755.76622116868;46881.296780549004;7393.149787774475;7448.106227252764;7501.437392195717;7633.2366763323225;7664.041994750656;10501.31741436804;11567.421628918688;11631;11720.531178752753;12140.210886292363;10277.177825773771;10393.53229104677;10531.315464494783;10630.362178269328;10660.786784264426;10272.280940334105;10387.37675739458;10437.217208709226;10530.684079477627;10669.199810014125;10397.948010259901;10483.37099774016;10537.57849686004;10686.198535110054;11049.502772375423;7408.592527411044;7423.257674232534;7481.177070522347;7554.3201111898;7604.2395760425725;8504;10357.4303413313;10442.164626829683;10495.317804342692;10661.786764264827 15:31:34 INFO - PROCESS | 3404 | |3;mootools.html;1199.1126566340909;1235.3390935849322;1268.6320966919593;1269.2955409747588;1464.1507925403266;7349.081364829396;7551.471397002212;7551.509151905122;7560.810979725509;7563.205863384348;7411.7776466705955;7512.774616761492;7536.81157971051;7544.170141284454;7566.735164269252;1892.0539730134933;2185.704929834476;2204.2946257197705;2235.8211343092594;2254.1096266974537;2254.627986382245;2256.0524579676494;2256.593813113639;2260.5026894083276;2267.161150374364;2152.332776839185;2247.8426510144213;2249.718785151856;2251.7297924249115;2254.391314345134;2224.6440569508964;2250.9437264068365;2252.5832720946596;2276.8178545716305;2282.463621049052;2185.2133232036454;2206.6579680149603;2212.9889350553303;2218.689383486313;2239.4401399650087;7762.301392874612;7814.179511151304;7821.178776228471;7825.843483130362;7829.1779363166615;4552.567506086916;4722.456917454502;4748.3114948332295;4752.1921273383605;4754.952450475485;3060.3573249617607;3090.227443139215;3166.699163579456;3169.065125787898;3196.7122958933805;980.6812785844558;986.9358491698017;987.7678745494803;1002.7493126718321;1023.5138309303096;10316.123129533999;10409.427481488516;10409.947950260275;10439.947800261027;10442.738931526697;4014.458048163519;4162.334026555736;4175.039740859619;4263.59495847894;4263.637590804754;8359.414840961075;8383.664653413916;8436.578171091422;8452.535110568977;8499.277561407225;3961.58403367648;4578;4622.913615300402;4623.075384923029;4627.537246275346;4204.3903633972905;4235.089455767024;4276.807543660543;4279.893002674958;4300.548442413564;3365.899023029313;3439.673231043047;3441.105312618687;3458.170039190576;3485.7385696072897;1025.5487585462372;1059.925805193629;1068.1081297116993;1071.3518321415431;1078.4014871746099;988.6292640259902;1014.6702321745315;1160.2516376936828;1180.8051671474282;1192.1595275330872;7014.473914456436;7096.92903070973;7104.751333703295;7175.784726458214;7180.60506672138;1067.5569638599893;1085.2674444749762;1086.8804431512526;1087.8857719939292;1093.6609651008214;5439.374471935699;5468.179773033997;5477.315335583052;5495.065838807413;5504.972475137679;8645.308375330083;8791.824163516694;8837.646494140163;8968.955155224312;9086.45481271126;9174.082591740906;9350.953245233866;9373.48445835472;9388.483633400092;9415.952920235355;7006.404455621329;7094.893576596355;7156.105486814148;7219.061522002211;7222.458315626349;7053.647317634201;7063.25835787235;7092.397146242627;7104.857902842017;7110.608916509642;8333.208345207195;8380.329573634217;8630.180132887366;8634.956825215833;8659.437136586102;8775.692850750193;8797.648094076165;8939;8940.73177804667;8950.373473856767;5977.491913187428;6242.157308763259;6364.363563643598;6814.114165158696;6991.825204369931;7033.191183014019;7047.929520704727;7050.753223637148;7085.610291433814;7086;6397.104405383157;6556.147700799056;6560.44236239925;6614.04096406028;6652.2349929756765;6321.715522801393;6543.116679248241;6577.967110164419;6633.668316584248;6675.265720770809;6719.428848547928;6726.8990965136545;6744.831379215559;6766.627835469097;6785.117934668461;6199.380061993765;6239.968800156152;6264.561480696308;6279.71741271653;6295.087212354275;6269.059641053878;6275.309715931336;6277.905831412441;6293.874122517615;6329.620222786648 15:31:34 INFO - PROCESS | 3404 | |4;prototype.html;314.6491661797096;318.77048525061946;319.50955283639615;327.9754018448617;329.71314955988294;5290.814821481249;5350.7859685612575;5359.222912677665;5404.567634589233;5412.56699464043;5298.894022119565;5312.92030619541;5322.2282768998475;5328.973355133219;5329.333833270841;3952.565217826037;4060.7563546187175;4142.192272506855;4154.086101057763;4160.791960401983;4164.521080075785;4183.163367326531;4184.686148538856;4184.7907604619795;4193.161367726451;4125.731827431207;4126.133511962492;4135.545090040093;4137.710360274767;4146.813393397304;3929.489166408363;4050.7569545827346;4118.546959834416;4144.316187829005;4145.502539695241;3643.125649844045;3650.5801832789302;3658.7804731716183;3661.4324779659196;3673.5959044505084;5043.621728370387;5047.419546752134;5064.696118232918;5079.23811428285;5081.949180508184;4775.2598347256235;4776.80892764289;4787.6648634595595;4794.304825800275;4796.208625576811;5591.608587398884;5593.04918163909;5608.158776183564;5610.579206559524;5617.101263797814;4025.2352053109817;4027.3958906164016;4031.959680403217;4033.3143365627916;4033.878983630496;5707.800226992077;5877.617954832922;5891.23413956183;5919.881602367972;5925.4370834770625;3934.252492026506;3940.9211815763524;3943.3493473576536;3955.7824319662695;3958.2281455116554;4007.5591684914634;4007.6593489553134;4009.3785463253244;4009.578994205625;4018.216447792652;4638.675292729544;4641.048585040126;4641.814327426865;4642.303654451792;4648.3259927310355;5612.466815652507;5616.775328986795;5619.662820230799;5623.775048998076;5624.437556244343;1382.8478867324586;1406.0298394108033;1407.5706909392734;1408.4366253498479;1409.0629731228823;927.1840780113457;935.242453612576;958.2860768727203;962.138885697297;962.9951850240705;4856.611471082305;4867.440244371943;4882.170031094723;4890.462049174588;4894.608431325485;5766.798162064308;5780.075187969905;5781.942180578225;5785.218995435563;5785.450382213767;4880.682755620874;4887.535684110004;4887.95112048882;4889.853304400874;4895.290182923456;3064.5290260674556;3100.240441091947;3101.875924963021;3104.487759519699;3109.8445077746023;5444.292242008513;5452.645578037414;5459.8362049137795;5466.262054622654;5471.23402723619;5719.456651618089;5880.382559831241;5899.056151015902;5900.970495147497;5907;5416.7020813855615;5430.728463576885;5438.945610543844;5442.591805614595;5466.644668096561;5769.9711501442225;5771.278590176228;5778.85552861165;5779.248697669276;5782.3639399666845;5637.661740295595;5638.182463542846;5639.464250896158;5646.774129034792;5646.887062258814;5408.161734931092;5434.83695489136;5436.374816895949;5444.128939369682;5453.863653408696;3857.787821669835;3983.6215559521797;3994.46074779901;4005.759654420744;4011.1576568919686;5576.219329293821;5756.65460072397;5786.5081468074;5794.507466865363;5797.130430435468;5476.561875050066;5605.915911261252;5618.157276408571;5651.350094739158;5672.801451949162;5574.247476590608;5610.775568977195;5616.85957851057;5618.157276408571;5621.634593751393;5547.472990065938;5553.194786755817;5556.694381809039;5562.72186390687;5564.693941833076;5681.034224181982;5689.146628005667;5691.345495267931;5701.258836351248;5705.885882282414;5381.246625472515;5533.059379905506;5542.63972841764;5563.527100196528;5569.972150139223 15:31:34 INFO - PROCESS | 3404 | |5;yui.html;611;695.8434352270737;706.2019917493232;752.8644843928091;776.1384862802292;12471.875281247185;12673.239605623658;12691.365431728424;12735.554255601055;12746.999999999989;13821.51624693136;13954.720905581882;13987.79018314726;13991.720165596682;14003.159810411382;646.7606985415403;808.9838203235931;817.840521098386;824.0235321144463;825.7522743177053;808.3573559020592;831.0276975938167;831.9542425166613;832.7043899415711;832.8042909916165;851.4465597361702;858.909814469481;862.9309655227598;862.9784255393603;862.9956850215772;683.1699485125547;843.1989609870617;844.5734903873566;853.5774791478227;855.0338117926765;623.6040114527262;626.2391194698463;628.3214128740995;628.8459327464755;629.4146443807257;12495.562655307021;12565.120441569094;12611.369431528386;12662.36688165588;12681.112322137455;11480.77038459226;12143.878561214364;12193.878061219362;12206.938965305206;12309.815352769716;9547.666407075476;9672.56473458696;9800.803983920354;9903.90096099037;9907.108360247541;3367.898963031113;3406.608240052401;3431.4166591679223;3503.2818272254126;3505.5442792437075;38336.42495362572;38929.22141557153;38979.61020389816;39014.609853901384;39066.218675626325;10000.899991000142;10079.193664506822;10204.489775511194;10288.948555257326;10434;17874.106294685214;17880.46358609244;17882.821171788375;17897.552561185814;17923.37268195607;6717.395434410926;6742.865142697118;6813.0121132435515;6892.345227203407;7079.2566780487305;3735.850565977385;3862.0537968197973;3891.1828516011387;3910.648041676263;3940.1725637616423;2929.765618750495;2934.32510522581;2934.8679309431127;2938.397628486155;2949.4985852405143;527.2802624417642;528.5243281047088;536.246573564143;538.8868337649059;545.3265217456438;552.2958228258922;626.37988391493;665.8867992441296;683.6615875141837;684.6850448793512;8220.424570280142;8236.958815205886;8258.463199891989;8269.95865020683;8515;635.8569321902535;650.1255810934285;653.9803805885831;660.2407231683602;676.0940339944498;3598.920323902819;3818.6372294631965;3884.5921178275876;3940.9211815764097;4022.2960981828646;46905;51208.48791512037;51294.74352628213;51369;51521.22718159231;41765.79117104395;42238.57761422346;43891;44128.77935610301;44575.55424445779;38946.41580376297;38987.2202555953;39004;39090;39424.21151576952;7704.768856934301;7928.326092282221;8006.799830004296;8052.677892884219;8099.595020249082;31027;31089.533656995616;31536;33863.83068084644;34021.767932046416;38790.41814372843;39184.80407597944;44247.336289955034;44343.556564433944;45447.318290226336;11375.601853935073;11506.654800356002;11651.76696466049;11677.708057298296;11830.585929492427;11811.527538898348;11921;12394.194377365442;13072.104544841135;13258.337083145998;11628.883711163118;11909.761804763682;12316.876831231932;12492.625221243377;12520.49918003306;11692.123090768397;11937.045036397241;11994.980426663482;12373.75252494927;12425.813612795997;10675.252732308663;11219.775604488028;11445.141614378788;11910.642680719593;11912.225705329125;9708.805823883342;9727.9027209727;9952.203823693942;9959.850602241117;10205.234607404325;9783.315167938175;9812.950935245279;9912.454814985245;9954.950225249117;9966.601335946481 15:31:34 INFO - PROCESS | 3404 | __end_tp_report 15:31:34 INFO - PROCESS | 3404 | __start_cc_report 15:31:34 INFO - PROCESS | 3404 | _x_x_mozilla_cycle_collect,822 15:31:34 INFO - PROCESS | 3404 | __end_cc_report 15:31:34 INFO - PROCESS | 3404 | __startTimestamp1458945094697__endTimestamp 15:31:34 INFO - PROCESS | 3404 | 15:31:34 INFO - PROCESS | 3404 | ------- Summary: start ------- 15:31:34 INFO - PROCESS | 3404 | Number of tests: 6 15:31:34 INFO - PROCESS | 3404 | 15:31:34 INFO - PROCESS | 3404 | [#0] dojo.html Cycles:165 Average:4618.75 Median:4739.22 stddev:473.06 (10.0%) stddev-sans-first:447.99 15:31:34 INFO - PROCESS | 3404 | Values: 2628.0 2635.8 2637.0 2645.5 2659.9 4617.4 4620.1 4651.9 4654.9 4663.2 4651.5 4659.8 4684.0 4722.4 4729.7 4258.9 4280.0 4305.9 4336.9 4447.2 4366.9 4396.2 4413.3 4425.7 4455.3 4168.3 4250.1 4258.4 4318.5 4325.0 4280.8 4313.8 4315.4 4354.8 4356.6 4188.2 4280.4 4284.5 4299.2 4343.5 4516.7 4527.8 4527.9 4547.2 4601.0 4939.1 4940.8 4954.3 4968.1 4976.9 4909.6 4991.8 5003.8 5009.9 5024.3 4685.4 4691.1 4701.6 4716.5 4734.4 5097.6 5100.1 5101.6 5106.2 5154.5 4810.3 4894.7 4899.2 4922.9 4992.5 4973.7 4997.6 4998.7 5000.6 5028.2 4945.6 4946.3 4959.0 4962.3 5001.3 4849.5 4947.9 4983.6 5001.2 5024.3 4267.6 4273.4 4278.4 4283.0 4296.3 3716.5 3728.8 3734.7 3741.7 3754.9 4164.3 4220.7 4246.3 4298.3 4314.9 5027.2 5032.1 5048.0 5054.5 5055.1 4343.3 4344.7 4353.9 4365.1 4399.9 4345.4 4524.8 4537.1 4560.9 4566.8 4761.6 4769.6 4784.3 4794.4 4844.2 5046.6 5047.5 5052.9 5064.3 5112.3 4689.2 4784.0 4786.6 4819.9 4837.9 4873.2 4886.9 4895.7 4913.6 4962.1 4884.6 4977.2 4994.5 4998.1 5036.2 4846.8 4854.2 4868.9 4893.2 4895.8 4710.2 4738.0 4739.2 4742.9 4795.9 4650.9 4670.7 4720.4 4729.9 4757.7 4867.9 4882.7 4889.4 4904.3 4932.0 4770.0 4777.4 4782.7 4787.0 4836.7 15:31:34 INFO - PROCESS | 3404 | 15:31:34 INFO - PROCESS | 3404 | [#1] ext.html Cycles:180 Average:38910.65 Median:33658.33 stddev:60623.87 (180.1%) stddev-sans-first:60725.57 15:31:34 INFO - PROCESS | 3404 | Values: 564.0 566.3 577.0 579.1 584.7 26993.5 27575.0 34390.5 34670.7 34891.7 37927.4 38019.8 38280.4 38394.6 38398.2 7494.2 7677.7 7678.4 7680.1 7682.0 7512.0 7672.0 7678.1 7685.4 7690.4 7672.6 7748.3 7895.5 7913.6 7928.8 7767.6 7791.9 7812.0 7839.8 7855.0 7761.5 7881.4 7885.1 7888.3 7889.4 36710.0 37527.8 37607.8 37636.2 37685.2 3124.2 3201.6 3225.7 3608.2 3917.6 27921.3 28260.9 28324.4 28347.0 28906.3 3482.0 3506.6 3521.6 3569.3 3649.1 221784.0 222977.0 223352.9 223563.0 223655.0 51823.2 52877.5 52882.0 52888.0 52916.7 61312.0 62298.0 62337.4 62343.0 62375.7 14125.1 14393.7 14416.6 14437.8 14447.1 10769.2 10828.8 10860.3 10861.6 10864.4 19791.0 19846.3 19935.4 20021.4 20114.6 7099.6 7726.7 7783.3 7851.5 7853.8 835.6 871.7 957.9 1006.0 1022.3 25873.0 26580.7 27046.0 27283.7 27327.6 864.5 998.4 999.2 1024.9 1040.7 12640.0 13106.5 13109.1 13169.4 13239.9 278533.0 284292.0 285318.0 286101.0 287843.0 45280.0 45895.5 45948.3 45968.5 45983.0 1044.5 1126.4 1215.9 1259.3 1314.4 25315.6 26875.2 26950.6 27176.6 27236.6 35239.8 35479.8 36159.3 36164.8 36199.6 168864.0 177585.1 179063.1 179227.0 179333.0 26815.5 27258.0 30078.2 30538.8 30930.7 34500.3 34508.7 35221.5 35415.6 35571.8 29826.4 30258.5 31407.4 32714.8 33507.7 31512.2 32511.3 32587.3 32816.7 32989.3 33337.7 33384.0 33809.0 33831.0 33872.8 27442.0 30111.7 30311.4 30319.4 30471.5 23479.4 23786.8 23969.0 24111.9 24177.4 15:31:34 INFO - PROCESS | 3404 | 15:31:34 INFO - PROCESS | 3404 | [#2] jquery.html Cycles:180 Average:24416.78 Median:21549.21 stddev:66180.46 (307.1%) stddev-sans-first:66341.42 15:31:34 INFO - PROCESS | 3404 | Values: 340.3 344.3 347.2 361.9 365.6 14531.4 15166.6 15844.2 15849.8 15856.4 16016.0 16188.4 17073.7 17601.3 17759.3 5458.6 5544.8 5620.7 5637.6 5654.3 5362.4 5486.7 5507.0 5524.2 5527.6 5508.7 5509.1 5561.2 5566.3 5664.6 5494.3 5637.0 5637.3 5688.8 5696.1 5454.3 5478.4 5487.8 5489.5 5937.5 20952.2 21209.8 21245.6 21374.9 22853.2 2060.7 2107.7 2217.4 2385.5 2542.4 13249.1 13775.1 13922.9 14014.7 14787.5 1890.3 1914.7 1935.3 1935.8 1947.0 65902.0 69203.3 69284.3 69445.3 70164.9 14592.2 14790.0 14866.6 14968.9 15163.2 24320.9 24460.0 24517.1 24633.8 24707.9 7968.6 7997.4 8340.7 8423.4 8436.9 6994.2 7103.8 7114.8 7160.1 7203.7 7375.6 7542.9 7577.5 7621.3 7644.0 2900.0 2919.7 2936.2 2972.8 3137.4 389.3 800.6 854.8 893.6 916.0 9792.8 10055.9 10066.2 10118.4 10495.3 414.5 420.3 428.5 438.2 443.7 5468.5 5494.9 5581.2 5699.6 5712.1 393278.0 394467.0 402839.0 410852.0 412105.0 68967.0 70944.6 71199.0 71416.3 71632.0 440.8 446.0 447.1 449.5 450.2 9348.0 9398.4 9468.5 9633.2 9776.0 28536.4 30521.0 30949.4 31288.7 31630.4 42678.1 44656.0 46509.8 46755.8 46881.3 7393.1 7448.1 7501.4 7633.2 7664.0 10501.3 11567.4 11631.0 11720.5 12140.2 10277.2 10393.5 10531.3 10630.4 10660.8 10272.3 10387.4 10437.2 10530.7 10669.2 10397.9 10483.4 10537.6 10686.2 11049.5 7408.6 7423.3 7481.2 7554.3 7604.2 8504.0 10357.4 10442.2 10495.3 10661.8 15:31:34 INFO - PROCESS | 3404 | 15:31:34 INFO - PROCESS | 3404 | [#3] mootools.html Cycles:180 Average:5302.47 Median:6266.81 stddev:2761.02 (44.1%) stddev-sans-first:2751.53 15:31:34 INFO - PROCESS | 3404 | Values: 1199.1 1235.3 1268.6 1269.3 1464.2 7349.1 7551.5 7551.5 7560.8 7563.2 7411.8 7512.8 7536.8 7544.2 7566.7 1892.1 2185.7 2204.3 2235.8 2254.1 2254.6 2256.1 2256.6 2260.5 2267.2 2152.3 2247.8 2249.7 2251.7 2254.4 2224.6 2250.9 2252.6 2276.8 2282.5 2185.2 2206.7 2213.0 2218.7 2239.4 7762.3 7814.2 7821.2 7825.8 7829.2 4552.6 4722.5 4748.3 4752.2 4755.0 3060.4 3090.2 3166.7 3169.1 3196.7 980.7 986.9 987.8 1002.7 1023.5 10316.1 10409.4 10409.9 10439.9 10442.7 4014.5 4162.3 4175.0 4263.6 4263.6 8359.4 8383.7 8436.6 8452.5 8499.3 3961.6 4578.0 4622.9 4623.1 4627.5 4204.4 4235.1 4276.8 4279.9 4300.5 3365.9 3439.7 3441.1 3458.2 3485.7 1025.5 1059.9 1068.1 1071.4 1078.4 988.6 1014.7 1160.3 1180.8 1192.2 7014.5 7096.9 7104.8 7175.8 7180.6 1067.6 1085.3 1086.9 1087.9 1093.7 5439.4 5468.2 5477.3 5495.1 5505.0 8645.3 8791.8 8837.6 8969.0 9086.5 9174.1 9351.0 9373.5 9388.5 9416.0 7006.4 7094.9 7156.1 7219.1 7222.5 7053.6 7063.3 7092.4 7104.9 7110.6 8333.2 8380.3 8630.2 8635.0 8659.4 8775.7 8797.6 8939.0 8940.7 8950.4 5977.5 6242.2 6364.4 6814.1 6991.8 7033.2 7047.9 7050.8 7085.6 7086.0 6397.1 6556.1 6560.4 6614.0 6652.2 6321.7 6543.1 6578.0 6633.7 6675.3 6719.4 6726.9 6744.8 6766.6 6785.1 6199.4 6240.0 6264.6 6279.7 6295.1 6269.1 6275.3 6277.9 6293.9 6329.6 15:31:34 INFO - PROCESS | 3404 | 15:31:34 INFO - PROCESS | 3404 | [#4] prototype.html Cycles:180 Average:4639.43 Median:5340.06 stddev:1362.35 (25.5%) stddev-sans-first:1326.94 15:31:34 INFO - PROCESS | 3404 | Values: 314.6 318.8 319.5 328.0 329.7 5290.8 5350.8 5359.2 5404.6 5412.6 5298.9 5312.9 5322.2 5329.0 5329.3 3952.6 4060.8 4142.2 4154.1 4160.8 4164.5 4183.2 4184.7 4184.8 4193.2 4125.7 4126.1 4135.5 4137.7 4146.8 3929.5 4050.8 4118.5 4144.3 4145.5 3643.1 3650.6 3658.8 3661.4 3673.6 5043.6 5047.4 5064.7 5079.2 5081.9 4775.3 4776.8 4787.7 4794.3 4796.2 5591.6 5593.0 5608.2 5610.6 5617.1 4025.2 4027.4 4032.0 4033.3 4033.9 5707.8 5877.6 5891.2 5919.9 5925.4 3934.3 3940.9 3943.3 3955.8 3958.2 4007.6 4007.7 4009.4 4009.6 4018.2 4638.7 4641.0 4641.8 4642.3 4648.3 5612.5 5616.8 5619.7 5623.8 5624.4 1382.8 1406.0 1407.6 1408.4 1409.1 927.2 935.2 958.3 962.1 963.0 4856.6 4867.4 4882.2 4890.5 4894.6 5766.8 5780.1 5781.9 5785.2 5785.5 4880.7 4887.5 4888.0 4889.9 4895.3 3064.5 3100.2 3101.9 3104.5 3109.8 5444.3 5452.6 5459.8 5466.3 5471.2 5719.5 5880.4 5899.1 5901.0 5907.0 5416.7 5430.7 5438.9 5442.6 5466.6 5770.0 5771.3 5778.9 5779.2 5782.4 5637.7 5638.2 5639.5 5646.8 5646.9 5408.2 5434.8 5436.4 5444.1 5453.9 3857.8 3983.6 3994.5 4005.8 4011.2 5576.2 5756.7 5786.5 5794.5 5797.1 5476.6 5605.9 5618.2 5651.4 5672.8 5574.2 5610.8 5616.9 5618.2 5621.6 5547.5 5553.2 5556.7 5562.7 5564.7 5681.0 5689.1 5691.3 5701.3 5705.9 5381.2 5533.1 5542.6 5563.5 5570.0 15:31:34 INFO - PROCESS | 3404 | 15:31:34 INFO - PROCESS | 3404 | [#5] yui.html Cycles:180 Average:12745.67 Median:21682.57 stddev:13777.05 (63.5%) stddev-sans-first:13785.56 15:31:34 INFO - PROCESS | 3404 | Values: 611.0 695.8 706.2 752.9 776.1 12471.9 12673.2 12691.4 12735.6 12747.0 13821.5 13954.7 13987.8 13991.7 14003.2 646.8 809.0 817.8 824.0 825.8 808.4 831.0 832.0 832.7 832.8 851.4 858.9 862.9 863.0 863.0 683.2 843.2 844.6 853.6 855.0 623.6 626.2 628.3 628.8 629.4 12495.6 12565.1 12611.4 12662.4 12681.1 11480.8 12143.9 12193.9 12206.9 12309.8 9547.7 9672.6 9800.8 9903.9 9907.1 3367.9 3406.6 3431.4 3503.3 3505.5 38336.4 38929.2 38979.6 39014.6 39066.2 10000.9 10079.2 10204.5 10288.9 10434.0 17874.1 17880.5 17882.8 17897.6 17923.4 6717.4 6742.9 6813.0 6892.3 7079.3 3735.9 3862.1 3891.2 3910.6 3940.2 2929.8 2934.3 2934.9 2938.4 2949.5 527.3 528.5 536.2 538.9 545.3 552.3 626.4 665.9 683.7 684.7 8220.4 8237.0 8258.5 8270.0 8515.0 635.9 650.1 654.0 660.2 676.1 3598.9 3818.6 3884.6 3940.9 4022.3 46905.0 51208.5 51294.7 51369.0 51521.2 41765.8 42238.6 43891.0 44128.8 44575.6 38946.4 38987.2 39004.0 39090.0 39424.2 7704.8 7928.3 8006.8 8052.7 8099.6 31027.0 31089.5 31536.0 33863.8 34021.8 38790.4 39184.8 44247.3 44343.6 45447.3 11375.6 11506.7 11651.8 11677.7 11830.6 11811.5 11921.0 12394.2 13072.1 13258.3 11628.9 11909.8 12316.9 12492.6 12520.5 11692.1 11937.0 11995.0 12373.8 12425.8 10675.3 11219.8 11445.1 11910.6 11912.2 9708.8 9727.9 9952.2 9959.9 10205.2 9783.3 9813.0 9912.5 9955.0 9966.6 15:31:34 INFO - PROCESS | 3404 | -------- Summary: end -------- 15:31:34 INFO - PROCESS | 3404 | 15:31:35 INFO - TEST-INFO | 3404: exit 0 15:31:35 INFO - TEST-OK | dromaeo_css | took 1118612ms 15:31:35 INFO - TEST-START | kraken 15:31:35 INFO - operating with platform_type : linux_ 15:31:35 INFO - Initialising browser for kraken test... 15:31:35 INFO - TEST-INFO | started process 3584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_4LpZ0/profile http://localhost:60907/getInfo.html) 15:31:39 INFO - PROCESS | 3584 | __metrics Screen width/height:1600/1200 15:31:39 INFO - PROCESS | 3584 | colorDepth:24 15:31:39 INFO - PROCESS | 3584 | Browser inner width/height: 1024/697 15:31:39 INFO - PROCESS | 3584 | __metrics 15:31:40 ERROR - PROCESS | 3584 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:31:41 INFO - TEST-INFO | 3584: exit 0 15:31:41 INFO - Browser initialized. 15:31:41 INFO - Running cycle 1/1 for kraken test... 15:31:41 INFO - TEST-INFO | started process 3669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_4LpZ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:53 INFO - PROCESS | 3669 | RSS: Main: 155090944 15:31:53 INFO - PROCESS | 3669 | 15:31:55 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60907/tests/kraken/driver.html?testName=audio-beat-detection) 15:31:56 INFO - PROCESS | 3669 | RSS: Main: 195686400 15:31:56 INFO - PROCESS | 3669 | 15:31:59 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60907/tests/kraken/driver.html?testName=audio-dft) 15:31:59 INFO - PROCESS | 3669 | RSS: Main: 186118144 15:31:59 INFO - PROCESS | 3669 | 15:32:02 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60907/tests/kraken/driver.html?testName=audio-fft) 15:32:03 INFO - PROCESS | 3669 | RSS: Main: 171679744 15:32:03 INFO - PROCESS | 3669 | 15:32:05 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60907/tests/kraken/driver.html?testName=audio-oscillator) 15:32:06 INFO - PROCESS | 3669 | RSS: Main: 172273664 15:32:06 INFO - PROCESS | 3669 | 15:32:08 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60907/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:32:08 INFO - PROCESS | 3669 | RSS: Main: 173871104 15:32:08 INFO - PROCESS | 3669 | 15:32:12 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60907/tests/kraken/driver.html?testName=imaging-darkroom) 15:32:12 INFO - PROCESS | 3669 | RSS: Main: 174415872 15:32:12 INFO - PROCESS | 3669 | 15:32:16 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60907/tests/kraken/driver.html?testName=imaging-desaturate) 15:32:16 INFO - PROCESS | 3669 | RSS: Main: 175767552 15:32:16 INFO - PROCESS | 3669 | 15:32:19 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60907/tests/kraken/driver.html?testName=json-parse-financial) 15:32:20 INFO - PROCESS | 3669 | RSS: Main: 175120384 15:32:20 INFO - PROCESS | 3669 | 15:32:21 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60907/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:32:22 INFO - PROCESS | 3669 | RSS: Main: 186826752 15:32:22 INFO - PROCESS | 3669 | 15:32:24 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60907/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:32:24 INFO - PROCESS | 3669 | RSS: Main: 184180736 15:32:24 INFO - PROCESS | 3669 | 15:32:27 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60907/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:32:28 INFO - PROCESS | 3669 | RSS: Main: 200220672 15:32:28 INFO - PROCESS | 3669 | 15:32:30 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:32:31 INFO - PROCESS | 3669 | RSS: Main: 201994240 15:32:31 INFO - PROCESS | 3669 | 15:32:33 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:32:34 INFO - PROCESS | 3669 | RSS: Main: 202657792 15:32:34 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:60907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60907/tests/kraken/driver.html?testName=ai-astar) 15:32:36 INFO - PROCESS | 3669 | RSS: Main: 264302592 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | __start_tp_report 15:32:36 INFO - PROCESS | 3669 | _x_x_mozilla_page_load 15:32:36 INFO - PROCESS | 3669 | _x_x_mozilla_page_load_details 15:32:36 INFO - PROCESS | 3669 | |i|pagename|runs| 15:32:36 INFO - PROCESS | 3669 | |0;ai-astar;113;115;109;113;114;111;101;114;113;115 15:32:36 INFO - PROCESS | 3669 | |1;audio-beat-detection;163;139;154;182;133;156;158;137;173;134 15:32:36 INFO - PROCESS | 3669 | |2;audio-dft;162;161;160;161;161;160;160;162;164;163 15:32:36 INFO - PROCESS | 3669 | |3;audio-fft;74;75;102;103;74;74;74;115;98;74 15:32:36 INFO - PROCESS | 3669 | |4;audio-oscillator;94;94;137;93;94;94;142;93;93;143 15:32:36 INFO - PROCESS | 3669 | |5;imaging-gaussian-blur;118;123;116;117;117;117;117;117;117;117 15:32:36 INFO - PROCESS | 3669 | |6;imaging-darkroom;147;147;146;146;146;146;147;146;146;146 15:32:36 INFO - PROCESS | 3669 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 15:32:36 INFO - PROCESS | 3669 | |8;json-parse-financial;64;65;64;65;64;64;65;73;62;63 15:32:36 INFO - PROCESS | 3669 | |9;json-stringify-tinderbox;64;64;63;65;64;64;64;65;64;64 15:32:36 INFO - PROCESS | 3669 | |10;stanford-crypto-aes;83;83;92;86;83;83;82;90;82;82 15:32:36 INFO - PROCESS | 3669 | |11;stanford-crypto-ccm;117;117;115;124;127;130;123;116;116;118 15:32:36 INFO - PROCESS | 3669 | |12;stanford-crypto-pbkdf2;131;138;156;143;144;133;143;144;152;144 15:32:36 INFO - PROCESS | 3669 | |13;stanford-crypto-sha256-iterative;68;69;71;67;68;67;68;67;67;65 15:32:36 INFO - PROCESS | 3669 | __end_tp_report 15:32:36 INFO - PROCESS | 3669 | __start_cc_report 15:32:36 INFO - PROCESS | 3669 | _x_x_mozilla_cycle_collect,1157 15:32:36 INFO - PROCESS | 3669 | __end_cc_report 15:32:36 INFO - PROCESS | 3669 | __startTimestamp1458945156316__endTimestamp 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | ------- Summary: start ------- 15:32:36 INFO - PROCESS | 3669 | Number of tests: 14 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:4.21 (3.7%) stddev-sans-first:4.44 15:32:36 INFO - PROCESS | 3669 | Values: 113.0 115.0 109.0 113.0 114.0 111.0 101.0 114.0 113.0 115.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:157.00 stddev:16.96 (10.8%) stddev-sans-first:17.59 15:32:36 INFO - PROCESS | 3669 | Values: 163.0 139.0 154.0 182.0 133.0 156.0 158.0 137.0 173.0 134.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 15:32:36 INFO - PROCESS | 3669 | Values: 162.0 161.0 160.0 161.0 161.0 160.0 160.0 162.0 164.0 163.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#3] audio-fft Cycles:10 Average:86.30 Median:74.00 stddev:16.23 (21.9%) stddev-sans-first:16.59 15:32:36 INFO - PROCESS | 3669 | Values: 74.0 75.0 102.0 103.0 74.0 74.0 74.0 115.0 98.0 74.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.50 stddev:22.80 (24.4%) stddev-sans-first:23.64 15:32:36 INFO - PROCESS | 3669 | Values: 94.0 94.0 137.0 93.0 94.0 94.0 142.0 93.0 93.0 143.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.96 (1.7%) stddev-sans-first:2.07 15:32:36 INFO - PROCESS | 3669 | Values: 118.0 123.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 15:32:36 INFO - PROCESS | 3669 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:32:36 INFO - PROCESS | 3669 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.50 stddev:3.00 (4.6%) stddev-sans-first:3.16 15:32:36 INFO - PROCESS | 3669 | Values: 64.0 65.0 64.0 65.0 64.0 64.0 65.0 73.0 62.0 63.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 15:32:36 INFO - PROCESS | 3669 | Values: 64.0 64.0 63.0 65.0 64.0 64.0 64.0 65.0 64.0 64.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:83.00 stddev:3.60 (4.3%) stddev-sans-first:3.77 15:32:36 INFO - PROCESS | 3669 | Values: 83.0 83.0 92.0 86.0 83.0 83.0 82.0 90.0 82.0 82.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:120.50 stddev:5.29 (4.4%) stddev-sans-first:5.48 15:32:36 INFO - PROCESS | 3669 | Values: 117.0 117.0 115.0 124.0 127.0 130.0 123.0 116.0 116.0 118.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:144.00 stddev:7.61 (5.3%) stddev-sans-first:6.77 15:32:36 INFO - PROCESS | 3669 | Values: 131.0 138.0 156.0 143.0 144.0 133.0 143.0 144.0 152.0 144.0 15:32:36 INFO - PROCESS | 3669 | 15:32:36 INFO - PROCESS | 3669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.57 (2.3%) stddev-sans-first:1.66 15:32:36 INFO - PROCESS | 3669 | Values: 68.0 69.0 71.0 67.0 68.0 67.0 68.0 67.0 67.0 65.0 15:32:36 INFO - PROCESS | 3669 | -------- Summary: end -------- 15:32:36 INFO - PROCESS | 3669 | 15:32:37 INFO - TEST-INFO | 3669: exit 0 15:32:37 INFO - TEST-OK | kraken | took 61879ms 15:32:37 INFO - SUITE-END | took 1180s 15:32:37 INFO - Completed test suite (00:19:40) 15:32:37 INFO - javascript benchmark 15:32:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2627.9605805912915, 2635.828671136376, 2636.9604455933154, 2645.4709058188355, 2659.9335016624586, 4617.353570500124, 4620.122176786413, 4651.906961860761, 4654.930176047358, 4663.207254766689, 4651.511591282917, 4659.790309436075, 4684.0, 4722.38608980832, 4729.668923175379, 4258.936115958263, 4279.957200427994, 4305.892352691192, 4336.891577710567, 4447.177272204653, 4366.868993930171, 4396.20868243716, 4413.293872980324, 4425.712328698641, 4455.331700244957, 4168.270552653274, 4250.149970006011, 4258.361245813153, 4318.52496225415, 4324.956750432487, 4280.807363668642, 4313.82744690212, 4315.395844581761, 4354.7604881731495, 4356.607905288539, 4188.183304255671, 4280.37934499499, 4284.464441944757, 4299.247631664478, 4343.478782546114, 4516.661250406232, 4527.750973696446, 4527.864164075083, 4547.226971414867, 4600.953990460086, 4939.086269040203, 4940.827071052496, 4954.281629163751, 4968.105740966625, 4976.925346119811, 4909.607231421478, 4991.777014631402, 5003.824866129705, 5009.922866583665, 5024.321716568253, 4685.437747470325, 4691.132140554008, 4701.553352431513, 4716.481187069419, 4734.360861283717, 5097.643164978416, 5100.056489549445, 5101.591872650179, 5106.183010718267, 5154.5103215194495, 4810.302506136661, 4894.681845680019, 4899.240617704261, 4922.926156107661, 4992.450830408652, 4973.651844370859, 4997.625178111656, 4998.700077995332, 5000.62495312853, 5028.2457631354855, 4945.579625731853, 4946.332245146931, 4959.0329885671945, 4962.330085438492, 5001.299818025479, 4849.4908034656555, 4947.851564453073, 4983.6013118950395, 5001.224810154432, 5024.296598476216, 4267.594578515036, 4273.401723758676, 4278.44380230568, 4282.957170428318, 4296.312589985588, 3716.5168528091176, 3728.8322025508373, 3734.7012239020814, 3741.663250307431, 3754.887353379403, 4164.292070348048, 4220.746755194698, 4246.278132717445, 4298.333758267411, 4314.935275970863, 5027.170516864677, 5032.119379108714, 5047.97476012625, 5054.469280725544, 5055.090083784954, 4343.305071188594, 4344.695871289043, 4353.934690979638, 4365.148795984816, 4399.934000989988, 4345.413369195181, 4524.8416305429155, 4537.115262523842, 4560.908781824345, 4566.8173273068705, 4761.619070474423, 4769.618430525549, 4784.282357646381, 4794.424669039738, 4844.15227335222, 5046.621503387188, 5047.4952504749235, 5052.873678158076, 5064.29099926018, 5112.258722485293, 4689.155951928686, 4783.95216047835, 4786.569208771228, 4819.879503012453, 4837.927431088466, 4873.1959226727195, 4886.926696099633, 4895.73073480962, 4913.606911447004, 4962.131626965194, 4884.584810291165, 4977.178765503796, 4994.51615624734, 4998.075356059141, 5036.194208926554, 4846.781894814812, 4854.17479028559, 4868.878278043077, 4893.192623217129, 4895.755212239445, 4710.199266124836, 4737.976310118427, 4739.21802902531, 4742.928856067093, 4795.904081918412, 4650.883727906829, 4670.743109129031, 4720.362751028567, 4729.858104256878, 4757.714537127784, 4867.853964381075, 4882.707037577757, 4889.437714662717, 4904.313396124474, 4932.0, 4770.045990801923, 4777.4267087949665, 4782.689125206851, 4786.95213047865, 4836.661433699607], "unit": "score", "name": "dojo.html", "value": 4589.2397369406035}, {"lowerIsBetter": false, "replicates": [563.9633423827454, 566.3204155013983, 577.0478710128291, 579.0677010013877, 584.748637914862, 26993.460130797397, 27575.0, 34390.48414273785, 34670.65329346706, 34891.65108348916, 37927.431088533696, 38019.809900950524, 38280.425793613045, 38394.616053839454, 38398.232035359346, 7494.175640679521, 7677.731279405222, 7678.42411819113, 7680.116786569532, 7682.0397450318715, 7512.0, 7672.0, 7678.117016543085, 7685.385169186452, 7690.384769218449, 7672.616369181546, 7748.263914928073, 7895.486793358442, 7913.643886025114, 7928.762137135866, 7767.572783496906, 7791.922080779176, 7812.0, 7839.764807055797, 7855.0, 7761.45669803114, 7881.448298619099, 7885.053793544754, 7888.329491993188, 7889.368850492005, 36710.0, 37527.8123609383, 37607.811960940024, 37636.24727505462, 37685.24629507394, 3124.1877111951057, 3201.631812341587, 3225.70968612826, 3608.206194637202, 3917.5886531914025, 27921.301967450774, 28260.93446783106, 28324.433511329866, 28347.0, 28906.27734306638, 3482.0, 3506.594105029001, 3521.5950165731015, 3569.303985722785, 3649.087728067983, 221784.0, 222977.0, 223352.88323558442, 223563.0, 223655.0, 51823.22265166025, 52877.471225287256, 52882.0, 52888.0, 52916.73541632267, 61312.0, 62298.0, 62337.376626234065, 62343.0, 62375.68812156001, 14125.081869678643, 14393.712125757636, 14416.567502974927, 14437.783433248509, 14447.060941038799, 10769.192310576738, 10828.78342433147, 10860.348379097279, 10861.565537378574, 10864.402457864893, 19791.0, 19846.305379311656, 19935.401937941886, 20021.399358019284, 20114.597708045756, 7099.574025558483, 7726.729564465217, 7783.299503044753, 7851.450398472166, 7853.842923141505, 835.6364981233183, 871.6687658689784, 957.899420560845, 1005.969820905374, 1022.320157095538, 25873.0, 26580.734192658212, 27046.0, 27283.727162728515, 27327.590086148724, 864.4726716702806, 998.3510718033336, 999.2256001598819, 1024.948752562369, 1040.6513817870946, 12640.040793676995, 13106.541271055657, 13109.082364234411, 13169.407376668072, 13239.867601324057, 278533.0, 284292.0, 285318.0, 286101.0, 287843.0, 45280.0, 45895.541044589794, 45948.310775338396, 45968.54031459709, 45982.99999999933, 1044.5090807320548, 1126.3692332293779, 1215.914885957992, 1259.3199672176922, 1314.4150852870573, 25315.62026569566, 26875.193744187705, 26950.59574106429, 27176.592351115145, 27236.591451128646, 35239.82380088083, 35479.82260088683, 36159.27681446409, 36164.819175903955, 36199.63800362068, 168864.0, 177585.1120744388, 179063.10468447575, 179227.0, 179333.0, 26815.463690726465, 27258.0, 30078.24804379908, 30538.847305763327, 30930.69069309278, 34500.30999380049, 34508.65491345055, 35221.47167792434, 35415.64584354227, 35571.82214088913, 29826.403471930873, 30258.54612180775, 31407.37185256328, 32714.83642581867, 33507.66492335046, 31512.212194695316, 32511.349773003934, 32587.34825303433, 32816.671833282315, 32989.26816589064, 33337.666623333454, 33384.0, 33809.0, 33831.0, 33872.830635846665, 27442.0, 30111.69888301089, 30311.393772123993, 30319.393612128075, 30471.542926855673, 23479.41301467477, 23786.762132378455, 23969.0, 24111.879440602686, 24177.395565111012], "unit": "score", "name": "ext.html", "value": 16649.477652401238}, {"lowerIsBetter": false, "replicates": [340.2803071503769, 344.30622296073415, 347.156409923885, 361.878770611845, 365.55950080153417, 14531.418743250257, 15166.62083447913, 15844.207789610517, 15849.762253566178, 15856.36574537017, 16016.0, 16188.433404830834, 17073.658526829455, 17601.295948162056, 17759.28962841485, 5458.645188062783, 5544.833654990357, 5620.718964051802, 5637.633553819009, 5654.321481422235, 5362.410134885159, 5486.698231597261, 5507.0, 5524.171374293848, 5527.640703354289, 5508.669479831203, 5509.121955603486, 5561.165825126243, 5566.332040155187, 5664.631798933076, 5494.2857428534235, 5637.0, 5637.267155269829, 5688.772449102031, 5696.11710184922, 5454.318210223722, 5478.397376288605, 5487.780488780444, 5489.533389661883, 5937.52499800015, 20952.16191352344, 21209.787902120937, 21245.5750884983, 21374.893125534272, 22853.20013799509, 2060.721802556651, 2107.662773956175, 2217.3569664797187, 2385.522895420923, 2542.3517003164075, 13249.13880597758, 13775.104618199784, 13922.860771392257, 14014.71970560583, 14787.482438114723, 1890.2627975089727, 1914.731937528747, 1935.2742721479444, 1935.77738560066, 1947.0362170725439, 65902.0, 69203.30796692018, 69284.3071569288, 69445.3055469444, 70164.94752578766, 14592.197429141286, 14789.968056548381, 14866.554003379915, 14968.92515537437, 15163.237969571492, 24320.87839560791, 24460.0, 24517.141900033414, 24633.753662463147, 24707.876460617943, 7968.641411136513, 7997.440179187517, 8340.749777506684, 8423.410361274775, 8436.873446898302, 6994.160700715946, 7103.751368702071, 7114.750983715545, 7160.069191005136, 7203.747868824566, 7375.594342311224, 7542.886856697154, 7577.507462014952, 7621.275978782007, 7643.9617801911745, 2899.9710002900124, 2919.664238612544, 2936.1665992317517, 2972.806767560102, 3137.419577378192, 389.3458988898621, 800.5676934455445, 854.8162145138825, 893.6157452295575, 915.9908400916039, 9792.755181120529, 10055.899441005642, 10066.194704423628, 10118.392896426238, 10495.317804342692, 414.54814252464956, 420.27922113574755, 428.5114968935416, 438.1849759447425, 443.6805500039966, 5468.453154684579, 5494.862628434241, 5581.162825576196, 5699.601027928005, 5712.057510510802, 393278.0, 394467.0, 402839.0, 410852.0, 412105.0, 68967.0, 70944.64527677432, 71199.0, 71416.28583714097, 71632.0, 440.82367053178984, 445.99777001114785, 447.05447977527945, 449.49207395642713, 450.1739308369179, 9347.953260233655, 9398.436093834393, 9468.526573671426, 9633.229341652792, 9776.0, 28536.429271414872, 30521.0, 30949.381012380076, 31288.687113128577, 31630.36739265248, 42678.14643707171, 44656.0, 46509.76745116253, 46755.76622116868, 46881.296780549004, 7393.149787774475, 7448.106227252764, 7501.437392195717, 7633.2366763323225, 7664.041994750656, 10501.31741436804, 11567.421628918688, 11631.0, 11720.531178752753, 12140.210886292363, 10277.177825773771, 10393.53229104677, 10531.315464494783, 10630.362178269328, 10660.786784264426, 10272.280940334105, 10387.37675739458, 10437.217208709226, 10530.684079477627, 10669.199810014125, 10397.948010259901, 10483.37099774016, 10537.57849686004, 10686.198535110054, 11049.502772375423, 7408.592527411044, 7423.257674232534, 7481.177070522347, 7554.3201111898, 7604.2395760425725, 8504.0, 10357.4303413313, 10442.164626829683, 10495.317804342692, 10661.786764264827], "unit": "score", "name": "jquery.html", "value": 8103.984833402032}, {"lowerIsBetter": false, "replicates": [1199.1126566340909, 1235.3390935849322, 1268.6320966919593, 1269.2955409747588, 1464.1507925403266, 7349.081364829396, 7551.471397002212, 7551.509151905122, 7560.810979725509, 7563.205863384348, 7411.7776466705955, 7512.774616761492, 7536.81157971051, 7544.170141284454, 7566.735164269252, 1892.0539730134933, 2185.704929834476, 2204.2946257197705, 2235.8211343092594, 2254.1096266974537, 2254.627986382245, 2256.0524579676494, 2256.593813113639, 2260.5026894083276, 2267.161150374364, 2152.332776839185, 2247.8426510144213, 2249.718785151856, 2251.7297924249115, 2254.391314345134, 2224.6440569508964, 2250.9437264068365, 2252.5832720946596, 2276.8178545716305, 2282.463621049052, 2185.2133232036454, 2206.6579680149603, 2212.9889350553303, 2218.689383486313, 2239.4401399650087, 7762.301392874612, 7814.179511151304, 7821.178776228471, 7825.843483130362, 7829.1779363166615, 4552.567506086916, 4722.456917454502, 4748.3114948332295, 4752.1921273383605, 4754.952450475485, 3060.3573249617607, 3090.227443139215, 3166.699163579456, 3169.065125787898, 3196.7122958933805, 980.6812785844558, 986.9358491698017, 987.7678745494803, 1002.7493126718321, 1023.5138309303096, 10316.123129533999, 10409.427481488516, 10409.947950260275, 10439.947800261027, 10442.738931526697, 4014.458048163519, 4162.334026555736, 4175.039740859619, 4263.59495847894, 4263.637590804754, 8359.414840961075, 8383.664653413916, 8436.578171091422, 8452.535110568977, 8499.277561407225, 3961.58403367648, 4578.0, 4622.913615300402, 4623.075384923029, 4627.537246275346, 4204.3903633972905, 4235.089455767024, 4276.807543660543, 4279.893002674958, 4300.548442413564, 3365.899023029313, 3439.673231043047, 3441.105312618687, 3458.170039190576, 3485.7385696072897, 1025.5487585462372, 1059.925805193629, 1068.1081297116993, 1071.3518321415431, 1078.4014871746099, 988.6292640259902, 1014.6702321745315, 1160.2516376936828, 1180.8051671474282, 1192.1595275330872, 7014.473914456436, 7096.92903070973, 7104.751333703295, 7175.784726458214, 7180.60506672138, 1067.5569638599893, 1085.2674444749762, 1086.8804431512526, 1087.8857719939292, 1093.6609651008214, 5439.374471935699, 5468.179773033997, 5477.315335583052, 5495.065838807413, 5504.972475137679, 8645.308375330083, 8791.824163516694, 8837.646494140163, 8968.955155224312, 9086.45481271126, 9174.082591740906, 9350.953245233866, 9373.48445835472, 9388.483633400092, 9415.952920235355, 7006.404455621329, 7094.893576596355, 7156.105486814148, 7219.061522002211, 7222.458315626349, 7053.647317634201, 7063.25835787235, 7092.397146242627, 7104.857902842017, 7110.608916509642, 8333.208345207195, 8380.329573634217, 8630.180132887366, 8634.956825215833, 8659.437136586102, 8775.692850750193, 8797.648094076165, 8939.0, 8940.73177804667, 8950.373473856767, 5977.491913187428, 6242.157308763259, 6364.363563643598, 6814.114165158696, 6991.825204369931, 7033.191183014019, 7047.929520704727, 7050.753223637148, 7085.610291433814, 7086.0, 6397.104405383157, 6556.147700799056, 6560.44236239925, 6614.04096406028, 6652.2349929756765, 6321.715522801393, 6543.116679248241, 6577.967110164419, 6633.668316584248, 6675.265720770809, 6719.428848547928, 6726.8990965136545, 6744.831379215559, 6766.627835469097, 6785.117934668461, 6199.380061993765, 6239.968800156152, 6264.561480696308, 6279.71741271653, 6295.087212354275, 6269.059641053878, 6275.309715931336, 6277.905831412441, 6293.874122517615, 6329.620222786648], "unit": "score", "name": "mootools.html", "value": 4340.747900182375}, {"lowerIsBetter": false, "replicates": [314.6491661797096, 318.77048525061946, 319.50955283639615, 327.9754018448617, 329.71314955988294, 5290.814821481249, 5350.7859685612575, 5359.222912677665, 5404.567634589233, 5412.56699464043, 5298.894022119565, 5312.92030619541, 5322.2282768998475, 5328.973355133219, 5329.333833270841, 3952.565217826037, 4060.7563546187175, 4142.192272506855, 4154.086101057763, 4160.791960401983, 4164.521080075785, 4183.163367326531, 4184.686148538856, 4184.7907604619795, 4193.161367726451, 4125.731827431207, 4126.133511962492, 4135.545090040093, 4137.710360274767, 4146.813393397304, 3929.489166408363, 4050.7569545827346, 4118.546959834416, 4144.316187829005, 4145.502539695241, 3643.125649844045, 3650.5801832789302, 3658.7804731716183, 3661.4324779659196, 3673.5959044505084, 5043.621728370387, 5047.419546752134, 5064.696118232918, 5079.23811428285, 5081.949180508184, 4775.2598347256235, 4776.80892764289, 4787.6648634595595, 4794.304825800275, 4796.208625576811, 5591.608587398884, 5593.04918163909, 5608.158776183564, 5610.579206559524, 5617.101263797814, 4025.2352053109817, 4027.3958906164016, 4031.959680403217, 4033.3143365627916, 4033.878983630496, 5707.800226992077, 5877.617954832922, 5891.23413956183, 5919.881602367972, 5925.4370834770625, 3934.252492026506, 3940.9211815763524, 3943.3493473576536, 3955.7824319662695, 3958.2281455116554, 4007.5591684914634, 4007.6593489553134, 4009.3785463253244, 4009.578994205625, 4018.216447792652, 4638.675292729544, 4641.048585040126, 4641.814327426865, 4642.303654451792, 4648.3259927310355, 5612.466815652507, 5616.775328986795, 5619.662820230799, 5623.775048998076, 5624.437556244343, 1382.8478867324586, 1406.0298394108033, 1407.5706909392734, 1408.4366253498479, 1409.0629731228823, 927.1840780113457, 935.242453612576, 958.2860768727203, 962.138885697297, 962.9951850240705, 4856.611471082305, 4867.440244371943, 4882.170031094723, 4890.462049174588, 4894.608431325485, 5766.798162064308, 5780.075187969905, 5781.942180578225, 5785.218995435563, 5785.450382213767, 4880.682755620874, 4887.535684110004, 4887.95112048882, 4889.853304400874, 4895.290182923456, 3064.5290260674556, 3100.240441091947, 3101.875924963021, 3104.487759519699, 3109.8445077746023, 5444.292242008513, 5452.645578037414, 5459.8362049137795, 5466.262054622654, 5471.23402723619, 5719.456651618089, 5880.382559831241, 5899.056151015902, 5900.970495147497, 5907.0, 5416.7020813855615, 5430.728463576885, 5438.945610543844, 5442.591805614595, 5466.644668096561, 5769.9711501442225, 5771.278590176228, 5778.85552861165, 5779.248697669276, 5782.3639399666845, 5637.661740295595, 5638.182463542846, 5639.464250896158, 5646.774129034792, 5646.887062258814, 5408.161734931092, 5434.83695489136, 5436.374816895949, 5444.128939369682, 5453.863653408696, 3857.787821669835, 3983.6215559521797, 3994.46074779901, 4005.759654420744, 4011.1576568919686, 5576.219329293821, 5756.65460072397, 5786.5081468074, 5794.507466865363, 5797.130430435468, 5476.561875050066, 5605.915911261252, 5618.157276408571, 5651.350094739158, 5672.801451949162, 5574.247476590608, 5610.775568977195, 5616.85957851057, 5618.157276408571, 5621.634593751393, 5547.472990065938, 5553.194786755817, 5556.694381809039, 5562.72186390687, 5564.693941833076, 5681.034224181982, 5689.146628005667, 5691.345495267931, 5701.258836351248, 5705.885882282414, 5381.246625472515, 5533.059379905506, 5542.63972841764, 5563.527100196528, 5569.972150139223], "unit": "score", "name": "prototype.html", "value": 4203.8545500169685}, {"lowerIsBetter": false, "replicates": [611.0, 695.8434352270737, 706.2019917493232, 752.8644843928091, 776.1384862802292, 12471.875281247185, 12673.239605623658, 12691.365431728424, 12735.554255601055, 12746.999999999989, 13821.51624693136, 13954.720905581882, 13987.79018314726, 13991.720165596682, 14003.159810411382, 646.7606985415403, 808.9838203235931, 817.840521098386, 824.0235321144463, 825.7522743177053, 808.3573559020592, 831.0276975938167, 831.9542425166613, 832.7043899415711, 832.8042909916165, 851.4465597361702, 858.909814469481, 862.9309655227598, 862.9784255393603, 862.9956850215772, 683.1699485125547, 843.1989609870617, 844.5734903873566, 853.5774791478227, 855.0338117926765, 623.6040114527262, 626.2391194698463, 628.3214128740995, 628.8459327464755, 629.4146443807257, 12495.562655307021, 12565.120441569094, 12611.369431528386, 12662.36688165588, 12681.112322137455, 11480.77038459226, 12143.878561214364, 12193.878061219362, 12206.938965305206, 12309.815352769716, 9547.666407075476, 9672.56473458696, 9800.803983920354, 9903.90096099037, 9907.108360247541, 3367.898963031113, 3406.608240052401, 3431.4166591679223, 3503.2818272254126, 3505.5442792437075, 38336.42495362572, 38929.22141557153, 38979.61020389816, 39014.609853901384, 39066.218675626325, 10000.899991000142, 10079.193664506822, 10204.489775511194, 10288.948555257326, 10434.0, 17874.106294685214, 17880.46358609244, 17882.821171788375, 17897.552561185814, 17923.37268195607, 6717.395434410926, 6742.865142697118, 6813.0121132435515, 6892.345227203407, 7079.2566780487305, 3735.850565977385, 3862.0537968197973, 3891.1828516011387, 3910.648041676263, 3940.1725637616423, 2929.765618750495, 2934.32510522581, 2934.8679309431127, 2938.397628486155, 2949.4985852405143, 527.2802624417642, 528.5243281047088, 536.246573564143, 538.8868337649059, 545.3265217456438, 552.2958228258922, 626.37988391493, 665.8867992441296, 683.6615875141837, 684.6850448793512, 8220.424570280142, 8236.958815205886, 8258.463199891989, 8269.95865020683, 8515.0, 635.8569321902535, 650.1255810934285, 653.9803805885831, 660.2407231683602, 676.0940339944498, 3598.920323902819, 3818.6372294631965, 3884.5921178275876, 3940.9211815764097, 4022.2960981828646, 46905.0, 51208.48791512037, 51294.74352628213, 51369.0, 51521.22718159231, 41765.79117104395, 42238.57761422346, 43891.0, 44128.77935610301, 44575.55424445779, 38946.41580376297, 38987.2202555953, 39004.0, 39090.0, 39424.21151576952, 7704.768856934301, 7928.326092282221, 8006.799830004296, 8052.677892884219, 8099.595020249082, 31027.0, 31089.533656995616, 31536.0, 33863.83068084644, 34021.767932046416, 38790.41814372843, 39184.80407597944, 44247.336289955034, 44343.556564433944, 45447.318290226336, 11375.601853935073, 11506.654800356002, 11651.76696466049, 11677.708057298296, 11830.585929492427, 11811.527538898348, 11921.0, 12394.194377365442, 13072.104544841135, 13258.337083145998, 11628.883711163118, 11909.761804763682, 12316.876831231932, 12492.625221243377, 12520.49918003306, 11692.123090768397, 11937.045036397241, 11994.980426663482, 12373.75252494927, 12425.813612795997, 10675.252732308663, 11219.775604488028, 11445.141614378788, 11910.642680719593, 11912.225705329125, 9708.805823883342, 9727.9027209727, 9952.203823693942, 9959.850602241117, 10205.234607404325, 9783.315167938175, 9812.950935245279, 9912.454814985245, 9954.950225249117, 9966.601335946481], "unit": "score", "name": "yui.html", "value": 6077.337276422108}], "name": "dromaeo_css", "value": 6399.331096484718}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 109.0, 113.0, 114.0, 111.0, 101.0, 114.0, 113.0, 115.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [163.0, 139.0, 154.0, 182.0, 133.0, 156.0, 158.0, 137.0, 173.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 152.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 102.0, 103.0, 74.0, 74.0, 74.0, 115.0, 98.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 137.0, 93.0, 94.0, 94.0, 142.0, 93.0, 93.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [118.0, 123.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 73.0, 62.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 64.9}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 92.0, 86.0, 83.0, 83.0, 82.0, 90.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 115.0, 124.0, 127.0, 130.0, 123.0, 116.0, 116.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.3}, {"lowerIsBetter": true, "replicates": [131.0, 138.0, 156.0, 143.0, 144.0, 133.0, 143.0, 144.0, 152.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1523.2999999999997}]} 15:32:37 INFO - Return code: 0 15:32:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:32:37 ERROR - # TBPL SUCCESS # 15:32:37 INFO - Running post-action listener: _resource_record_post_action 15:32:37 INFO - Running post-run listener: _resource_record_post_run 15:32:38 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 10366976; Write bytes: 426917888; Read time: 2208; Write time: 456676 15:32:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 94355456; Read time: 0; Write time: 106008 15:32:38 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8630272; Write bytes: 332562432; Read time: 2160; Write time: 350668 15:32:38 INFO - Running post-run listener: _upload_blobber_files 15:32:38 INFO - Blob upload gear active. 15:32:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:32:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:32:39 INFO - (blobuploader) - INFO - Open directory for files ... 15:32:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:32:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:32:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:39 INFO - (blobuploader) - INFO - Done attempting. 15:32:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:32:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:32:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:40 INFO - (blobuploader) - INFO - Done attempting. 15:32:40 INFO - (blobuploader) - INFO - Iteration through files over. 15:32:40 INFO - Return code: 0 15:32:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:32:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:32:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa70a0ec3672c06acbf2df7e98330c8908b8aed41baa035ac1e07a9679e7f973e6adb2a4e4f62d7bd5ca2aa61a2ff9815494947f22f4eb5588f2320de358ce56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bafc90f7798033557af0a3020093fddc51070cd39a6dc518626e270c479d95f40a92054276e57dbe00c42e8bf6d8c9525282bb23955af8c1cf88d27b8f2e2294"} 15:32:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:32:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:32:40 INFO - Contents: 15:32:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa70a0ec3672c06acbf2df7e98330c8908b8aed41baa035ac1e07a9679e7f973e6adb2a4e4f62d7bd5ca2aa61a2ff9815494947f22f4eb5588f2320de358ce56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bafc90f7798033557af0a3020093fddc51070cd39a6dc518626e270c479d95f40a92054276e57dbe00c42e8bf6d8c9525282bb23955af8c1cf88d27b8f2e2294"} 15:32:40 INFO - Running post-run listener: copy_logs_to_upload_dir 15:32:40 INFO - Copying logs to upload dir... 15:32:40 INFO - mkdir: /builds/slave/test/build/upload/logs 15:32:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.949510 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-25 15:32:40.932894) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 15:32:40.936015) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852 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/fa70a0ec3672c06acbf2df7e98330c8908b8aed41baa035ac1e07a9679e7f973e6adb2a4e4f62d7bd5ca2aa61a2ff9815494947f22f4eb5588f2320de358ce56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bafc90f7798033557af0a3020093fddc51070cd39a6dc518626e270c479d95f40a92054276e57dbe00c42e8bf6d8c9525282bb23955af8c1cf88d27b8f2e2294"} build_url:https://queue.taskcluster.net/v1/task/TQfYJFx2S_2UJHNzw6q4xA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011113 build_url: 'https://queue.taskcluster.net/v1/task/TQfYJFx2S_2UJHNzw6q4xA/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/fa70a0ec3672c06acbf2df7e98330c8908b8aed41baa035ac1e07a9679e7f973e6adb2a4e4f62d7bd5ca2aa61a2ff9815494947f22f4eb5588f2320de358ce56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bafc90f7798033557af0a3020093fddc51070cd39a6dc518626e270c479d95f40a92054276e57dbe00c42e8bf6d8c9525282bb23955af8c1cf88d27b8f2e2294"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 15:32:40.983757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 15:32:40.984315) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1458943814.32609-1006335852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 15:32:41.048884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 15:32:41.049553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 15:32:41.050207) ========= ========= Total master_lag: 0.64 =========