builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1456506874.61 results: success (0) buildid: 20160226081035 builduid: 202f2348e00740f982646f76052c6791 revision: 0f3938e0df6405678c951e2541019354c109732b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.608162) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.608819) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.609097) ========= 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=4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009009 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.636283) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.636556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.677552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.677913) ========= 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=4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.032690 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.731145) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.731411) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.731747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.732014) ========= 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=4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 09:14:34-- 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% 9.78M=0.001s 2016-02-26 09:14:34 (9.78 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136237 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.886681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:34.886996) ========= 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=4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.146259 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:35.045906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:35.046266) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0f3938e0df6405678c951e2541019354c109732b --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 0f3938e0df6405678c951e2541019354c109732b --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=4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 09:14:35,134 truncating revision to first 12 chars 2016-02-26 09:14:35,134 Setting DEBUG logging. 2016-02-26 09:14:35,134 attempt 1/10 2016-02-26 09:14:35,134 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0f3938e0df64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 09:14:35,473 unpacking tar archive at: fx-team-0f3938e0df64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651263 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:35.710553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:35.710894) ========= echo 0f3938e0df6405678c951e2541019354c109732b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0f3938e0df6405678c951e2541019354c109732b'] 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=4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0f3938e0df6405678c951e2541019354c109732b program finished with exit code 0 elapsedTime=0.003996 script_repo_revision: '0f3938e0df6405678c951e2541019354c109732b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:35.760359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:35.760674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 09:14:35.770766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-02-26 09:14:35.771124) ========= /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=4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:14:35 INFO - MultiFileLogger online at 20160226 09:14:35 in /builds/slave/test 09:14:35 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 09:14:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:35 INFO - {'append_to_log': False, 09:14:35 INFO - 'base_work_dir': '/builds/slave/test', 09:14:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:14:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:35 INFO - 'branch': 'Fx-Team-Non-PGO', 09:14:35 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:35 INFO - 'config_files': ('talos/linux_config.py',), 09:14:35 INFO - 'default_actions': ('clobber', 09:14:35 INFO - 'read-buildbot-config', 09:14:35 INFO - 'download-and-extract', 09:14:35 INFO - 'populate-webroot', 09:14:35 INFO - 'create-virtualenv', 09:14:35 INFO - 'install', 09:14:35 INFO - 'run-tests'), 09:14:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:35 INFO - 'download_minidump_stackwalk': True, 09:14:35 INFO - 'download_symbols': 'ondemand', 09:14:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:35 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:35 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:35 INFO - 'installer_path': 'installer.exe', 09:14:35 INFO - 'log_level': 'info', 09:14:35 INFO - 'log_name': 'talos', 09:14:35 INFO - 'log_to_console': True, 09:14:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:14:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:14:35 INFO - 'opt_config_files': (), 09:14:35 INFO - 'pip_index': False, 09:14:35 INFO - 'sps_profile': False, 09:14:35 INFO - 'sps_profile_interval': 0, 09:14:35 INFO - 'suite': 'dromaeojs', 09:14:35 INFO - 'system_bits': '32', 09:14:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:35 INFO - 'title': 'talos-linux64-ix-024', 09:14:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:35 INFO - 'use_talos_json': True, 09:14:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:35 INFO - 'work_dir': 'build'} 09:14:35 INFO - ##### 09:14:35 INFO - ##### Running clobber step. 09:14:35 INFO - ##### 09:14:35 INFO - Running pre-action listener: _resource_record_pre_action 09:14:35 INFO - Running main action method: clobber 09:14:35 INFO - rmtree: /builds/slave/test/build 09:14:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:40 INFO - Running post-action listener: _resource_record_post_action 09:14:40 INFO - ##### 09:14:40 INFO - ##### Running read-buildbot-config step. 09:14:40 INFO - ##### 09:14:40 INFO - Running pre-action listener: _resource_record_pre_action 09:14:40 INFO - Running main action method: read_buildbot_config 09:14:40 INFO - Using buildbot properties: 09:14:40 INFO - { 09:14:40 INFO - "project": "", 09:14:40 INFO - "product": "firefox", 09:14:40 INFO - "script_repo_revision": "production", 09:14:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:14:40 INFO - "repository": "", 09:14:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:14:40 INFO - "buildid": "20160226081035", 09:14:40 INFO - "pgo_build": "False", 09:14:40 INFO - "basedir": "/builds/slave/test", 09:14:40 INFO - "buildnumber": 2555, 09:14:40 INFO - "slavename": "talos-linux64-ix-024", 09:14:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:14:40 INFO - "platform": "ubuntu64_hw", 09:14:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:14:40 INFO - "branch": "fx-team", 09:14:40 INFO - "repo_path": "integration/fx-team", 09:14:40 INFO - "revision": "0f3938e0df6405678c951e2541019354c109732b", 09:14:40 INFO - "stage_platform": "linux64", 09:14:40 INFO - "builduid": "202f2348e00740f982646f76052c6791", 09:14:40 INFO - "slavebuilddir": "test" 09:14:40 INFO - } 09:14:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 09:14:40 INFO - Running post-action listener: _resource_record_post_action 09:14:40 INFO - ##### 09:14:40 INFO - ##### Running download-and-extract step. 09:14:40 INFO - ##### 09:14:40 INFO - Running pre-action listener: _resource_record_pre_action 09:14:40 INFO - Running main action method: download_and_extract 09:14:40 INFO - mkdir: /builds/slave/test/build/tests 09:14: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')]} 09:14:40 INFO - https://queue.taskcluster.net/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/test_packages.json 09:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/test_packages.json 09:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:14:41 INFO - Downloaded 1448 bytes. 09:14:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:14:41 INFO - Using the following test package requirements: 09:14:41 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:41 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:14:41 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:14:41 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:41 INFO - u'jsshell-linux-x86_64.zip'], 09:14:41 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:14:41 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:41 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:14:41 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:14:41 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:14:41 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:41 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:14:41 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:41 INFO - https://queue.taskcluster.net/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:14:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:14:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:14:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:48 INFO - Downloaded 22056233 bytes. 09:14:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:14:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:14:49 INFO - Return code: 0 09:14:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:49 INFO - https://queue.taskcluster.net/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:14:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:14:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:14:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:50 INFO - Downloaded 22056233 bytes. 09:14:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:14:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:14:51 INFO - Return code: 0 09:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:51 INFO - https://queue.taskcluster.net/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:14:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:14:53 INFO - Downloaded 10713410 bytes. 09:14:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:14:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:14:54 INFO - Return code: 0 09:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:54 INFO - https://queue.taskcluster.net/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:14:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:14:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:14:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:14:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:14:56 INFO - Downloaded 54831746 bytes. 09:14:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:14:56 INFO - mkdir: /builds/slave/test/properties 09:14:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:14:56 INFO - Writing to file /builds/slave/test/properties/build_url 09:14:56 INFO - Contents: 09:14:56 INFO - build_url:https://queue.taskcluster.net/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:14:57 INFO - Running post-action listener: _resource_record_post_action 09:14:57 INFO - Running post-action listener: set_extra_try_arguments 09:14:57 INFO - ##### 09:14:57 INFO - ##### Running populate-webroot step. 09:14:57 INFO - ##### 09:14:57 INFO - Running pre-action listener: _resource_record_pre_action 09:14:57 INFO - Running main action method: populate_webroot 09:14:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:57 INFO - '--tppagecycles', 09:14:57 INFO - '7'], 09:14:57 INFO - 'tests': ['tsvgm']}}, 09:14:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:14:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:14:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:14:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:14:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:14:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:57 INFO - 'talos_options': ['--e10s'], 09:14:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:57 INFO - 'tests': ['damp', 'tps']}, 09:14:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:57 INFO - 'talos_options': ['--e10s'], 09:14:57 INFO - 'tests': ['damp', 'tps']}, 09:14:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:14:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:14:57 INFO - 'other': {'tests': ['a11yr', 09:14:57 INFO - 'ts_paint', 09:14:57 INFO - 'tpaint', 09:14:57 INFO - 'sessionrestore', 09:14:57 INFO - 'sessionrestore_no_auto_restore']}, 09:14:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:14:57 INFO - 'tests': ['a11yr', 09:14:57 INFO - 'ts_paint', 09:14:57 INFO - 'tpaint', 09:14:57 INFO - 'sessionrestore', 09:14:57 INFO - 'sessionrestore_no_auto_restore']}, 09:14:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:14:57 INFO - 'tests': ['a11yr', 09:14:57 INFO - 'ts_paint', 09:14:57 INFO - 'tpaint', 09:14:57 INFO - 'sessionrestore', 09:14:57 INFO - 'sessionrestore_no_auto_restore']}, 09:14:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:14:57 INFO - 'tests': ['a11yr', 09:14:57 INFO - 'ts_paint', 09:14:57 INFO - 'tpaint', 09:14:57 INFO - 'sessionrestore', 09:14:57 INFO - 'sessionrestore_no_auto_restore']}, 09:14:57 INFO - 'other_l64': {'tests': ['a11yr', 09:14:57 INFO - 'ts_paint', 09:14:57 INFO - 'tpaint', 09:14:57 INFO - 'sessionrestore', 09:14:57 INFO - 'sessionrestore_no_auto_restore']}, 09:14:57 INFO - 'other_nol64': {'tests': ['a11yr', 09:14:57 INFO - 'ts_paint', 09:14:57 INFO - 'tpaint', 09:14:57 INFO - 'sessionrestore', 09:14:57 INFO - 'sessionrestore_no_auto_restore']}, 09:14:57 INFO - 'svgr': {'tests': ['tsvgx', 09:14:57 INFO - 'tsvgr_opacity', 09:14:57 INFO - 'tart', 09:14:57 INFO - 'tscrollx', 09:14:57 INFO - 'cart']}, 09:14:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:14:57 INFO - 'tests': ['tsvgx', 09:14:57 INFO - 'tsvgr_opacity', 09:14:57 INFO - 'tart', 09:14:57 INFO - 'tscrollx', 09:14:57 INFO - 'cart']}, 09:14:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:57 INFO - 'tests': ['tp5o']}, 09:14:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:57 INFO - 'talos_options': ['--e10s'], 09:14:57 INFO - 'tests': ['tp5o']}, 09:14:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:57 INFO - 'talos_options': ['--xperf_path', 09:14:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:57 INFO - 'tests': ['tp5n']}, 09:14:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:57 INFO - 'talos_options': ['--e10s', 09:14:57 INFO - '--xperf_path', 09:14:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:57 INFO - 'tests': ['tp5n']}}, 09:14:57 INFO - 'talos.zip': {'path': '', 09:14:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:57 INFO - Running post-action listener: _resource_record_post_action 09:14:57 INFO - ##### 09:14:57 INFO - ##### Running create-virtualenv step. 09:14:57 INFO - ##### 09:14:57 INFO - Running pre-action listener: _resource_record_pre_action 09:14:57 INFO - Running main action method: create_virtualenv 09:14:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:14:57 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 09:14:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:14:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:57 INFO - Using real prefix '/usr' 09:14:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:14:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:15:01 INFO - Installing pip.................done. 09:15:01 INFO - Return code: 0 09:15:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:15:01 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')]} 09:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:01 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')]} 09:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:01 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 0x7f3aa0564f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e33b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1472100>, '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 0x1473000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1473490>, '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': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', '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 09:15:01 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 09:15:01 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 09:15:01 INFO - Using env: {'DISPLAY': ':0', 09:15:01 INFO - 'HOME': '/home/cltbld', 09:15:01 INFO - 'LANG': 'en_US.UTF-8', 09:15:01 INFO - 'LANGUAGE': 'en_US:en', 09:15:01 INFO - 'LOGNAME': 'cltbld', 09:15:01 INFO - 'MAIL': '/var/mail/cltbld', 09:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:01 INFO - 'MOZ_NO_REMOTE': '1', 09:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:01 INFO - 'NO_EM_RESTART': '1', 09:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:01 INFO - 'PWD': '/builds/slave/test', 09:15:01 INFO - 'SHELL': '/bin/bash', 09:15:01 INFO - 'SHLVL': '1', 09:15:01 INFO - 'TERM': 'linux', 09:15:01 INFO - 'TMOUT': '86400', 09:15:01 INFO - 'USER': 'cltbld', 09:15:01 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', 09:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:01 INFO - '_': '/tools/buildbot/bin/python'} 09:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:01 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 09:15:01 INFO - Cleaning up... 09:15:01 INFO - Return code: 0 09:15:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:15:01 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')]} 09:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:01 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')]} 09:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:01 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 0x7f3aa0564f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e33b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1472100>, '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 0x1473000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1473490>, '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': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', '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 09:15:01 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 09:15:01 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 09:15:01 INFO - Using env: {'DISPLAY': ':0', 09:15:01 INFO - 'HOME': '/home/cltbld', 09:15:01 INFO - 'LANG': 'en_US.UTF-8', 09:15:01 INFO - 'LANGUAGE': 'en_US:en', 09:15:01 INFO - 'LOGNAME': 'cltbld', 09:15:01 INFO - 'MAIL': '/var/mail/cltbld', 09:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:01 INFO - 'MOZ_NO_REMOTE': '1', 09:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:01 INFO - 'NO_EM_RESTART': '1', 09:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:01 INFO - 'PWD': '/builds/slave/test', 09:15:01 INFO - 'SHELL': '/bin/bash', 09:15:01 INFO - 'SHLVL': '1', 09:15:01 INFO - 'TERM': 'linux', 09:15:01 INFO - 'TMOUT': '86400', 09:15:01 INFO - 'USER': 'cltbld', 09:15:01 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', 09:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:01 INFO - '_': '/tools/buildbot/bin/python'} 09:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:01 INFO - Downloading/unpacking psutil>=0.7.1 09:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:15:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:03 INFO - Installing collected packages: psutil 09:15:03 INFO - Running setup.py install for psutil 09:15:03 INFO - building 'psutil._psutil_linux' extension 09:15:03 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 09:15:03 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 09:15:03 INFO - building 'psutil._psutil_posix' extension 09:15:03 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 09:15:03 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 09:15:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:04 INFO - Successfully installed psutil 09:15:04 INFO - Cleaning up... 09:15:04 INFO - Return code: 0 09:15:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3aa0564f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e33b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1472100>, '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 0x1473000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1473490>, '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': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', '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 09:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:15:04 INFO - Using env: {'DISPLAY': ':0', 09:15:04 INFO - 'HOME': '/home/cltbld', 09:15:04 INFO - 'LANG': 'en_US.UTF-8', 09:15:04 INFO - 'LANGUAGE': 'en_US:en', 09:15:04 INFO - 'LOGNAME': 'cltbld', 09:15:04 INFO - 'MAIL': '/var/mail/cltbld', 09:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:04 INFO - 'MOZ_NO_REMOTE': '1', 09:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:04 INFO - 'NO_EM_RESTART': '1', 09:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:04 INFO - 'PWD': '/builds/slave/test', 09:15:04 INFO - 'SHELL': '/bin/bash', 09:15:04 INFO - 'SHLVL': '1', 09:15:04 INFO - 'TERM': 'linux', 09:15:04 INFO - 'TMOUT': '86400', 09:15:04 INFO - 'USER': 'cltbld', 09:15:04 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', 09:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:04 INFO - '_': '/tools/buildbot/bin/python'} 09:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:15:06 INFO - Installing collected packages: mozsystemmonitor 09:15:06 INFO - Running setup.py install for mozsystemmonitor 09:15:06 INFO - Successfully installed mozsystemmonitor 09:15:06 INFO - Cleaning up... 09:15:06 INFO - Return code: 0 09:15:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3aa0564f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e33b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1472100>, '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 0x1473000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1473490>, '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': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', '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 09:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:15:06 INFO - Using env: {'DISPLAY': ':0', 09:15:06 INFO - 'HOME': '/home/cltbld', 09:15:06 INFO - 'LANG': 'en_US.UTF-8', 09:15:06 INFO - 'LANGUAGE': 'en_US:en', 09:15:06 INFO - 'LOGNAME': 'cltbld', 09:15:06 INFO - 'MAIL': '/var/mail/cltbld', 09:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:06 INFO - 'MOZ_NO_REMOTE': '1', 09:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:06 INFO - 'NO_EM_RESTART': '1', 09:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:06 INFO - 'PWD': '/builds/slave/test', 09:15:06 INFO - 'SHELL': '/bin/bash', 09:15:06 INFO - 'SHLVL': '1', 09:15:06 INFO - 'TERM': 'linux', 09:15:06 INFO - 'TMOUT': '86400', 09:15:06 INFO - 'USER': 'cltbld', 09:15:06 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', 09:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:06 INFO - '_': '/tools/buildbot/bin/python'} 09:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:06 INFO - Downloading/unpacking blobuploader==1.2.4 09:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:08 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:15:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:09 INFO - Downloading docopt-0.6.1.tar.gz 09:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:09 INFO - Running setup.py install for blobuploader 09:15:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:15:09 INFO - Running setup.py install for requests 09:15:09 INFO - Running setup.py install for docopt 09:15:09 INFO - Successfully installed blobuploader requests docopt 09:15:09 INFO - Cleaning up... 09:15:09 INFO - Return code: 0 09:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:09 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 0x7f3aa0564f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e33b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1472100>, '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 0x1473000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1473490>, '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': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', '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 09:15:09 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 09:15:09 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 09:15:09 INFO - Using env: {'DISPLAY': ':0', 09:15:09 INFO - 'HOME': '/home/cltbld', 09:15:09 INFO - 'LANG': 'en_US.UTF-8', 09:15:09 INFO - 'LANGUAGE': 'en_US:en', 09:15:09 INFO - 'LOGNAME': 'cltbld', 09:15:09 INFO - 'MAIL': '/var/mail/cltbld', 09:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:09 INFO - 'MOZ_NO_REMOTE': '1', 09:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:09 INFO - 'NO_EM_RESTART': '1', 09:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:09 INFO - 'PWD': '/builds/slave/test', 09:15:09 INFO - 'SHELL': '/bin/bash', 09:15:09 INFO - 'SHLVL': '1', 09:15:09 INFO - 'TERM': 'linux', 09:15:09 INFO - 'TMOUT': '86400', 09:15:09 INFO - 'USER': 'cltbld', 09:15:09 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', 09:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:09 INFO - '_': '/tools/buildbot/bin/python'} 09:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:09 INFO - Running setup.py (path:/tmp/pip-jUN5nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:10 INFO - Running setup.py (path:/tmp/pip-EZjc1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:10 INFO - Running setup.py (path:/tmp/pip-AGyvr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:10 INFO - Running setup.py (path:/tmp/pip-V5pRRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:10 INFO - Running setup.py (path:/tmp/pip-JAjgTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:10 INFO - Running setup.py (path:/tmp/pip-CjMdW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:10 INFO - Running setup.py (path:/tmp/pip-wZBJVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:10 INFO - Running setup.py (path:/tmp/pip-zZnXln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:10 INFO - Running setup.py (path:/tmp/pip-72KKVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:10 INFO - Running setup.py (path:/tmp/pip-1FcWV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:10 INFO - Running setup.py (path:/tmp/pip-d4i74a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:10 INFO - Running setup.py (path:/tmp/pip-DG9mx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:10 INFO - Running setup.py (path:/tmp/pip-afluLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:10 INFO - Running setup.py (path:/tmp/pip-fIA_3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:10 INFO - Running setup.py (path:/tmp/pip-o4sfvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:11 INFO - Running setup.py (path:/tmp/pip-JZcckj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:11 INFO - Running setup.py (path:/tmp/pip-Y5tFIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:11 INFO - Running setup.py install for manifestparser 09:15:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Running setup.py install for mozcrash 09:15:11 INFO - Running setup.py install for mozdebug 09:15:11 INFO - Running setup.py install for mozdevice 09:15:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Running setup.py install for mozfile 09:15:11 INFO - Running setup.py install for mozhttpd 09:15:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Running setup.py install for mozinfo 09:15:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Running setup.py install for mozInstall 09:15:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Running setup.py install for mozleak 09:15:12 INFO - Running setup.py install for mozlog 09:15:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for moznetwork 09:15:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for mozprocess 09:15:12 INFO - Running setup.py install for mozprofile 09:15:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for mozrunner 09:15:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for mozscreenshot 09:15:12 INFO - Running setup.py install for moztest 09:15:12 INFO - Running setup.py install for mozversion 09:15:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:15:12 INFO - Cleaning up... 09:15:12 INFO - Return code: 0 09:15:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:12 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')]} 09:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:12 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')]} 09:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:12 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 0x7f3aa0564f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e33b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1472100>, '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 0x1473000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1473490>, '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': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', '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 09:15:12 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 09:15:12 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 09:15:12 INFO - Using env: {'DISPLAY': ':0', 09:15:12 INFO - 'HOME': '/home/cltbld', 09:15:12 INFO - 'LANG': 'en_US.UTF-8', 09:15:12 INFO - 'LANGUAGE': 'en_US:en', 09:15:12 INFO - 'LOGNAME': 'cltbld', 09:15:12 INFO - 'MAIL': '/var/mail/cltbld', 09:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:12 INFO - 'MOZ_NO_REMOTE': '1', 09:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:12 INFO - 'NO_EM_RESTART': '1', 09:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:12 INFO - 'PWD': '/builds/slave/test', 09:15:12 INFO - 'SHELL': '/bin/bash', 09:15:12 INFO - 'SHLVL': '1', 09:15:12 INFO - 'TERM': 'linux', 09:15:12 INFO - 'TMOUT': '86400', 09:15:12 INFO - 'USER': 'cltbld', 09:15:12 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', 09:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:12 INFO - '_': '/tools/buildbot/bin/python'} 09:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:13 INFO - Running setup.py (path:/tmp/pip-YSePX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:13 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:13 INFO - Running setup.py (path:/tmp/pip-6AbkRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:13 INFO - Running setup.py (path:/tmp/pip-7BJIpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:13 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:13 INFO - Running setup.py (path:/tmp/pip-NfYchh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:13 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:13 INFO - Running setup.py (path:/tmp/pip-exZ73I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:13 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:13 INFO - Running setup.py (path:/tmp/pip-u28ITZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:13 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:13 INFO - Running setup.py (path:/tmp/pip-Sa5lud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:13 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:13 INFO - Running setup.py (path:/tmp/pip-Hx3trw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:13 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:13 INFO - Running setup.py (path:/tmp/pip-vl8DL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:13 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:13 INFO - Running setup.py (path:/tmp/pip-3cKg9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:13 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:13 INFO - Running setup.py (path:/tmp/pip-Qbtw1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:13 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)) 09:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:14 INFO - Running setup.py (path:/tmp/pip-06pOml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:14 INFO - Running setup.py (path:/tmp/pip-SVA8hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:14 INFO - Running setup.py (path:/tmp/pip-Hdjubs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:14 INFO - Running setup.py (path:/tmp/pip-cLWKOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:14 INFO - Running setup.py (path:/tmp/pip-uANOyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:14 INFO - Running setup.py (path:/tmp/pip-beTKfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:14 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)) 09:15:14 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:15:14 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:15:14 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)) 09:15:14 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)) 09:15:14 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)) 09:15:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:14 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 09:15:14 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 09:15:14 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 09:15:14 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 09:15:14 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 09:15:14 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 09:15:16 INFO - Downloading blessings-1.6.tar.gz 09:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:16 INFO - Installing collected packages: blessings 09:15:16 INFO - Running setup.py install for blessings 09:15:16 INFO - Successfully installed blessings 09:15:16 INFO - Cleaning up... 09:15:16 INFO - Return code: 0 09:15:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:16 INFO - Reading from file tmpfile_stdout 09:15:16 INFO - Current package versions: 09:15:16 INFO - argparse == 1.2.1 09:15:16 INFO - blessings == 1.6 09:15:16 INFO - blobuploader == 1.2.4 09:15:16 INFO - docopt == 0.6.1 09:15:16 INFO - manifestparser == 1.1 09:15:16 INFO - mozInstall == 1.12 09:15:16 INFO - mozcrash == 0.16 09:15:16 INFO - mozdebug == 0.1 09:15:16 INFO - mozdevice == 0.48 09:15:16 INFO - mozfile == 1.2 09:15:16 INFO - mozhttpd == 0.7 09:15:16 INFO - mozinfo == 0.9 09:15:16 INFO - mozleak == 0.1 09:15:16 INFO - mozlog == 3.1 09:15:16 INFO - moznetwork == 0.27 09:15:16 INFO - mozprocess == 0.22 09:15:16 INFO - mozprofile == 0.28 09:15:16 INFO - mozrunner == 6.11 09:15:16 INFO - mozscreenshot == 0.1 09:15:16 INFO - mozsystemmonitor == 0.0 09:15:16 INFO - moztest == 0.7 09:15:16 INFO - mozversion == 1.4 09:15:16 INFO - psutil == 3.1.1 09:15:16 INFO - requests == 1.2.3 09:15:16 INFO - wsgiref == 0.1.2 09:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:16 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 0x7f3aa0564f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e33b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1472100>, '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 0x1473000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1473490>, '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': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', '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 09:15:16 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 09:15:16 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 09:15:16 INFO - Using env: {'DISPLAY': ':0', 09:15:16 INFO - 'HOME': '/home/cltbld', 09:15:16 INFO - 'LANG': 'en_US.UTF-8', 09:15:16 INFO - 'LANGUAGE': 'en_US:en', 09:15:16 INFO - 'LOGNAME': 'cltbld', 09:15:16 INFO - 'MAIL': '/var/mail/cltbld', 09:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:16 INFO - 'MOZ_NO_REMOTE': '1', 09:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:16 INFO - 'NO_EM_RESTART': '1', 09:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:16 INFO - 'PWD': '/builds/slave/test', 09:15:16 INFO - 'SHELL': '/bin/bash', 09:15:16 INFO - 'SHLVL': '1', 09:15:16 INFO - 'TERM': 'linux', 09:15:16 INFO - 'TMOUT': '86400', 09:15:16 INFO - 'USER': 'cltbld', 09:15:16 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', 09:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:16 INFO - '_': '/tools/buildbot/bin/python'} 09:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:16 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)) 09:15:16 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)) 09:15:16 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)) 09:15:16 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)) 09:15:16 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)) 09:15:16 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)) 09:15:16 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)) 09:15:16 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)) 09:15:16 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)) 09:15:16 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)) 09:15:16 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)) 09:15:16 INFO - Cleaning up... 09:15:16 INFO - Return code: 0 09:15:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3aa0564f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e33b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1472100>, '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 0x1473000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1473490>, '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': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', '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 09:15: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', 'jsonschema'] in /builds/slave/test/build 09:15: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 jsonschema 09:15:16 INFO - Using env: {'DISPLAY': ':0', 09:15:16 INFO - 'HOME': '/home/cltbld', 09:15:16 INFO - 'LANG': 'en_US.UTF-8', 09:15:16 INFO - 'LANGUAGE': 'en_US:en', 09:15:16 INFO - 'LOGNAME': 'cltbld', 09:15:16 INFO - 'MAIL': '/var/mail/cltbld', 09:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:16 INFO - 'MOZ_NO_REMOTE': '1', 09:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:16 INFO - 'NO_EM_RESTART': '1', 09:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:16 INFO - 'PWD': '/builds/slave/test', 09:15:16 INFO - 'SHELL': '/bin/bash', 09:15:16 INFO - 'SHLVL': '1', 09:15:16 INFO - 'TERM': 'linux', 09:15:16 INFO - 'TMOUT': '86400', 09:15:16 INFO - 'USER': 'cltbld', 09:15:16 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', 09:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:16 INFO - '_': '/tools/buildbot/bin/python'} 09:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:17 INFO - Downloading/unpacking jsonschema 09:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:18 INFO - Downloading/unpacking functools32 (from jsonschema) 09:15:18 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 09:15:18 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 09:15:18 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 09:15:18 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 09:15:18 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 09:15:18 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 09:15:19 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:19 INFO - warning: no files found matching '*.txt' 09:15:19 INFO - no previously-included directories found matching 'build' 09:15:19 INFO - no previously-included directories found matching 'dist' 09:15:19 INFO - no previously-included directories found matching '.git*' 09:15:19 INFO - Installing collected packages: jsonschema, functools32 09:15:19 INFO - Running setup.py install for functools32 09:15:19 INFO - warning: no files found matching '*.txt' 09:15:19 INFO - no previously-included directories found matching 'build' 09:15:19 INFO - no previously-included directories found matching 'dist' 09:15:19 INFO - no previously-included directories found matching '.git*' 09:15:19 INFO - Successfully installed jsonschema functools32 09:15:19 INFO - Cleaning up... 09:15:19 INFO - Return code: 0 09:15:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:15:19 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')]} 09:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:19 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')]} 09:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:19 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 0x7f3aa0564f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e33b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1472100>, '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 0x1473000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1473490>, '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': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', '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 09:15:19 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 09:15:19 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 09:15:19 INFO - Using env: {'DISPLAY': ':0', 09:15:19 INFO - 'HOME': '/home/cltbld', 09:15:19 INFO - 'LANG': 'en_US.UTF-8', 09:15:19 INFO - 'LANGUAGE': 'en_US:en', 09:15:19 INFO - 'LOGNAME': 'cltbld', 09:15:19 INFO - 'MAIL': '/var/mail/cltbld', 09:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:19 INFO - 'MOZ_NO_REMOTE': '1', 09:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:19 INFO - 'NO_EM_RESTART': '1', 09:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:19 INFO - 'PWD': '/builds/slave/test', 09:15:19 INFO - 'SHELL': '/bin/bash', 09:15:19 INFO - 'SHLVL': '1', 09:15:19 INFO - 'TERM': 'linux', 09:15:19 INFO - 'TMOUT': '86400', 09:15:19 INFO - 'USER': 'cltbld', 09:15:19 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', 09:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:19 INFO - '_': '/tools/buildbot/bin/python'} 09:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:19 INFO - Downloading/unpacking flake8 09:15:19 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 09:15:19 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 09:15:19 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 09:15:19 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 09:15:19 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 09:15:19 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 09:15:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:15:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:15:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 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 09:15:21 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 09:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:15:22 INFO - no previously-included directories found matching 'docs/_build' 09:15:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:15:22 INFO - Running setup.py install for pep8 09:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:15:22 INFO - no previously-included directories found matching 'docs/_build' 09:15:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:15:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:15:22 INFO - Cleaning up... 09:15:22 INFO - Return code: 0 09:15:22 INFO - Running post-action listener: _resource_record_post_action 09:15:22 INFO - Running post-action listener: _start_resource_monitoring 09:15:22 INFO - Starting resource monitoring. 09:15:22 INFO - ##### 09:15:22 INFO - ##### Running install step. 09:15:22 INFO - ##### 09:15:22 INFO - Running pre-action listener: _resource_record_pre_action 09:15:22 INFO - Running main action method: install 09:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:22 INFO - Reading from file tmpfile_stdout 09:15:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:15:22 INFO - Reading from file tmpfile_stdout 09:15:22 INFO - Output received: 09:15:22 INFO - Usage: mozinstall [options] installer 09:15:22 INFO - Options: 09:15:22 INFO - -h, --help show this help message and exit 09:15:22 INFO - -d DEST, --destination=DEST 09:15:22 INFO - Directory to install application into. [default: 09:15:22 INFO - "/builds/slave/test"] 09:15:22 INFO - --app=APP Application being installed. [default: firefox] 09:15:22 INFO - mkdir: /builds/slave/test/build/application 09:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:15:38 INFO - Reading from file tmpfile_stdout 09:15:38 INFO - Output received: 09:15:38 INFO - /builds/slave/test/build/application/firefox/firefox 09:15:38 INFO - Running post-action listener: _resource_record_post_action 09:15:38 INFO - ##### 09:15:38 INFO - ##### Running run-tests step. 09:15:38 INFO - ##### 09:15:38 INFO - Running pre-action listener: _resource_record_pre_action 09:15:38 INFO - Running main action method: run_tests 09:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:15:38 INFO - Python 2.7.3 09:15:38 INFO - Return code: 0 09:15:38 INFO - grabbing minidump binary from tooltool 09:15:38 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')]} 09:15:38 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 0x1472100>, '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 0x1473000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1473490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:15:38 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 09:15:38 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 09:15:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:15:38 INFO - Return code: 0 09:15:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:15:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:15:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:15:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:15:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:15:39 INFO - Return code: 0 09:15:39 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/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:15:39 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/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:15:39 INFO - Using env: {'DISPLAY': ':0', 09:15:39 INFO - 'HOME': '/home/cltbld', 09:15:39 INFO - 'LANG': 'en_US.UTF-8', 09:15:39 INFO - 'LANGUAGE': 'en_US:en', 09:15:39 INFO - 'LOGNAME': 'cltbld', 09:15:39 INFO - 'MAIL': '/var/mail/cltbld', 09:15:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:15:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:39 INFO - 'MOZ_NO_REMOTE': '1', 09:15:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:39 INFO - 'NO_EM_RESTART': '1', 09:15:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:39 INFO - 'PWD': '/builds/slave/test', 09:15:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:15:39 INFO - 'SHELL': '/bin/bash', 09:15:39 INFO - 'SHLVL': '1', 09:15:39 INFO - 'TERM': 'linux', 09:15:39 INFO - 'TMOUT': '86400', 09:15:39 INFO - 'USER': 'cltbld', 09:15:39 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141', 09:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:39 INFO - '_': '/tools/buildbot/bin/python'} 09:15:39 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/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:15:39 INFO - mozversion application_buildid: 20160226081035 09:15:39 INFO - mozversion application_changeset: 0f3938e0df6405678c951e2541019354c109732b 09:15:39 INFO - mozversion application_display_name: Nightly 09:15:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:15:39 INFO - mozversion application_name: Firefox 09:15:39 INFO - mozversion application_remotingname: firefox 09:15:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:15:39 INFO - mozversion application_vendor: Mozilla 09:15:39 INFO - mozversion application_version: 47.0a1 09:15:39 INFO - mozversion platform_buildid: 20160226081035 09:15:39 INFO - mozversion platform_changeset: 0f3938e0df6405678c951e2541019354c109732b 09:15:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:15:39 INFO - mozversion platform_version: 47.0a1 09:15:39 INFO - using testdate: 1456506939 09:15:39 INFO - actual date: 1456506939 09:15:39 INFO - starting webserver on 'localhost:45556' 09:15:39 INFO - SUITE-START | Running 2 tests 09:15:39 INFO - TEST-START | dromaeo_css 09:15:39 INFO - operating with platform_type : linux_ 09:15:39 INFO - Initialising browser for dromaeo_css test... 09:15:39 INFO - TEST-INFO | started process 4422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZZVFDz/profile http://localhost:45556/getInfo.html) 09:15:44 INFO - PROCESS | 4422 | __metrics Screen width/height:1600/1200 09:15:44 INFO - PROCESS | 4422 | colorDepth:24 09:15:44 INFO - PROCESS | 4422 | Browser inner width/height: 1024/697 09:15:44 INFO - PROCESS | 4422 | __metrics 09:15:45 INFO - PROCESS | 4422 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:46 INFO - TEST-INFO | 4422: exit 0 09:15:46 INFO - Browser initialized. 09:15:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:15:46 INFO - TEST-INFO | started process 4518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZZVFDz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:58 INFO - PROCESS | 4518 | RSS: Main: 147644416 09:15:58 INFO - PROCESS | 4518 | 09:16:49 INFO - PROCESS | 4518 | 1456507009289 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] 09:19:00 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:45556/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45556/tests/dromaeo/cssquery-ext.html) 09:19:01 INFO - PROCESS | 4518 | RSS: Main: 238616576 09:19:01 INFO - PROCESS | 4518 | 09:22:03 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:45556/tests/dromaeo/cssquery-ext.html (next: http://localhost:45556/tests/dromaeo/cssquery-jquery.html) 09:22:04 INFO - PROCESS | 4518 | RSS: Main: 229978112 09:22:04 INFO - PROCESS | 4518 | 09:25:06 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:45556/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45556/tests/dromaeo/cssquery-mootools.html) 09:25:06 INFO - PROCESS | 4518 | RSS: Main: 235393024 09:25:06 INFO - PROCESS | 4518 | 09:28:08 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:45556/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45556/tests/dromaeo/cssquery-prototype.html) 09:28:09 INFO - PROCESS | 4518 | RSS: Main: 207884288 09:28:09 INFO - PROCESS | 4518 | 09:31:11 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:45556/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45556/tests/dromaeo/cssquery-yui.html) 09:31:12 INFO - PROCESS | 4518 | RSS: Main: 192249856 09:31:12 INFO - PROCESS | 4518 | 09:34:15 INFO - PROCESS | 4518 | Cycle 1(1): loaded http://localhost:45556/tests/dromaeo/cssquery-yui.html (next: http://localhost:45556/tests/dromaeo/cssquery-dojo.html) 09:34:15 INFO - PROCESS | 4518 | RSS: Main: 254025728 09:34:15 INFO - PROCESS | 4518 | 09:34:15 INFO - PROCESS | 4518 | __start_tp_report 09:34:15 INFO - PROCESS | 4518 | _x_x_mozilla_page_load 09:34:15 INFO - PROCESS | 4518 | _x_x_mozilla_page_load_details 09:34:15 INFO - PROCESS | 4518 | |i|pagename|runs| 09:34:15 INFO - PROCESS | 4518 | |0;dojo.html;2584.3926677230847;2646.5103955768172;2662.227953893371;2669.3860412105214;2697.473992571448;4266.189424009436;4362.083962367902;4377.365282034103;4387.978060109699;4402.427684401027;4379.255526560484;4405.6695747818885;4434.467863856342;4435.423394958659;4473.060657261971;4016.2971479990883;4059.654929330996;4063.7968101594874;4101.569335219789;4137.151883863816;4009.719319647626;4069.7151199416053;4114.485689288839;4128.339465685491;4144.026153853842;4053.4730485037053;4145.440365550642;4163.542010378856;4168.187203495319;4170.16596680662;4094.0583665757044;4117.547069822317;4122.9381559276635;4153.127843152942;4153.273177193979;3957.168994511156;4070.979645101785;4119.340905455113;4122.113745544692;4162.500499939996;4279.315309550457;4316.072044510414;4380.277254253045;4397.5602439756085;4417.050334178135;4660.487346391894;4679.27471241958;4679.438467383936;4686.929696054562;4710.5289471052965;4616.053708989649;4691.906161876777;4699.271612900006;4700.320817134235;4745.074710431467;4444.511103778582;4446;4448.466184057934;4486.192485352668;4487.416635837386;4860.392450943632;4863.270509423544;4865.1242776300605;4865.95134048662;4867.3915760529935;4482.1707984022405;4592.242280023758;4668.369770080995;4680.789364478606;4719.433667959866;4706.717596944194;4717.481077081518;4732.716037037789;4742.549457801503;4758.714477131383;4663.440387153563;4672.672912896132;4675.368825208621;4683.157031734252;4736.194846876039;4505.774711264424;4556.476005259371;4619.884502887455;4622.560856718606;4640.883977900579;3887.455756194135;3907.8241479133508;3922.7057970652313;3948.763074215556;3949.743266687656;3487.128217945514;3492.5808902931813;3497.0208341664375;3528.894133176009;3531.6291789362263;3938.1729836734035;4008.659263962596;4050.10897602527;4140.668746500272;4142.813573389205;4668.5798278155125;4703.529647035338;4710.387649605529;4715.905681886343;4760.357351757469;4071.5521292657786;4079;4080.10237747695;4111.465509483808;4111.8560850370095;4106.630403263721;4169.812358443877;4216.3464662977285;4221.514525829508;4246.320588705792;4482.238019536621;4485.304777759453;4503.144402563503;4503.684742068024;4540.205464043779;4533;4719.716816990992;4720.575148236675;4721.929171062506;4750.548697873696;4502.729836209838;4546.977265113654;4554.362389265571;4574.931376029295;4599.126166028444;4658.510856360033;4674.11191873543;4676.625869930329;4678.345031695633;4703.247480403256;4573.199690054294;4731.384919960383;4744.1460537102275;4747.64392670558;4775.116603428377;4597.057603191404;4601.608863246662;4604.378408914888;4608.88477788058;4647.814087436464;4570.862874113782;4594.678372514026;4602.951860587747;4620.722756634613;4651.325557794168;4406.339049142654;4488.640908727229;4525.230710779241;4528.230200865795;4546.1135078659345;4590.517995610413;4608.746518941491;4610.5389461054965;4629.375034370317;4643.930341044955;4514.706544074625;4516.074204788077;4516.390287311171;4543.863684089482;4551.203539380661 09:34:15 INFO - PROCESS | 4518 | |1;ext.html;480.92305231163;493.01889240411595;511.1106674386566;519.0708631549526;520.6069417589721;25035.37411564712;33700.83149584252;34045;34045.14887127817;34136.317273654546;35976.280474390565;36388.81805590968;36454.27091458169;36500.45249321256;36501.817490912574;6870.141232345957;7578.204288549692;7773.416993725465;7776.027996500437;9365;9557.61769529218;9737.853932191023;9748;9749.122578967892;9749.610015599403;9691.370060946016;9837;9841.36031157976;9847;9847.901520984806;9654.5172741363;9755.951220243853;9762.072603102764;9765.462899540522;9774.364666296739;9573.329866909318;9714.271429642806;9716.708498744978;9717.271204659608;9990.550425230882;36724.81637591795;37031.814840925894;37063;37098.443523347174;37101;3140.4661207594763;3299.307145499448;3428.160100775301;3605.47720580517;3728.7762734236035;27790.444191116065;27824.443511129866;28075.57886631702;28151.718482815115;28479.857600711865;3387.9491807622903;3418.7265018798685;3445.776024558396;3509.7367697422796;3560.5015297858063;228629;230883;231051;231235.9999999983;231959;52594.737026315386;53230.73384633052;53250.73374633102;53269.2009619856;53305.46694533005;56274;57054.14418783721;57063;57066.00806915297;57122;11034.613788517363;12783.936080319725;13043.543475978295;13152.736945261042;13163.276019819003;8076.4750291230885;8230.917690823015;8251.917480825115;9741.561629726679;10053.447060411747;18246;18315.816841831678;18350.908245458686;18485;18510.16704248312;7313.414926805843;7672.271134242238;7696.076470823425;7713.19011503784;7748.7675369739;822.4530687093016;869.8434281829332;932.5337331334333;941.7975135345933;955.7467271173144;25002.624960625606;26052.73947260541;26057.348566285993;26093.869530652606;26264.737352626613;947.6446332625266;951.9476428796482;979.7648564344648;1062.102523367753;1104.47537419725;13267.469301227842;13477.817820305703;13505.189688618715;13726.588202353945;13878.236696981763;260225;264212;265594;266204;267005;45024;45754;45787.31319030217;45828.08343833105;45840;975.492743773234;1079.8002369561657;1173.8180582009802;1228.5577192210797;1237.8205160251894;22685.2060177893;22905.08379664795;22947.196848110238;23268;23441;36022.099447514025;36885;36951.076223094635;37024;37026.814865925495;227118;232197;233457;233713;233742;24672.629910550997;29308.97418590339;29324.706752932198;29829;39513.802430987664;37826.24347513089;37929;38240.23519529538;38684.22631547297;38836;34031.31937361189;34772.82613586916;35410.291794164485;35476.113097172776;35764.284714306086;34817.30365392729;35088;35111.297774044884;35408.645913541564;35449.645503544634;34524.48213276853;35215.47176792401;35323.29353412969;35450;35560.288794224485;29521.852390738768;31732.682673173895;31939.520907186874;32038.519422209152;32214.19464513406;24531.14141005056;24691;24790.752092478844;25020.499590007734;26247.86876065684 09:34:15 INFO - PROCESS | 4518 | |2;jquery.html;329.2838077182128;332.2723236112913;335.14872224549646;336.1562478179768;336.9561956945598;14317.72238874339;14830.184339861304;14916.403343866246;15304.84695153048;15373.615659608515;8881.733547993554;9247.768805779859;14066.296685165751;14307;14315.355808988594;4409.7354158750495;4542.250528662767;4549.795259213327;4579.542045795427;4587.8623641290815;4532.297493888453;4571.5657012583915;4580.221362368388;4588.609968152711;4649.930251046237;4854.490278520758;4960.057589058068;4988.376452943382;4993.5755460785695;4994.525520075587;4973.4280557735965;5017.5985921126585;5031.094403007457;5033.899322013557;5037.19404895215;4497.820087196508;4572.657050721209;4762.38089048425;4767.713937163781;4768.856934291976;11277.943610281896;11289.0968722502;11310.773784524346;11318.547258109666;13682.452701892013;1894.6494898443832;1908.8663793534458;1918.3957053528095;1921.3851567498407;1985.553250518636;8572.185642363966;8690.782730431727;8691.782705432352;8748.475091494467;12163.209391389531;1724.5688577855535;1780.5459607800058;1808.095952023988;1833.5507800588807;1845.8515478854563;39858.60141398578;47258.76370618159;52783.208251876255;53482;54507.454925450635;8569.143085691381;8625.439346442461;8773.649054037767;8915.643374264957;9368.2973776967;11399.886001140048;11426.200165988468;11504.424778761197;11517.654470365902;11524.481398337095;6504.447121994589;6799.388055074968;6801.285864984205;6886.380225779704;6905.654717264117;6598.37315455031;6628.403443689995;6709.7316107355155;6716.5634233774645;6718.160229971254;3766.981165094157;3776.8866933992026;3798.210735586481;3878.864239751595;3983.143624120828;1645.7284548049677;1670.4237038221795;1685.679720853034;1695.5930576661758;1716.5794380376637;684.4558575932145;848.7284069097952;858.3818905265056;864.9264812491009;967.2697113679127;15267.23663816827;15470.381184752483;15558.079977678812;15758.133302668462;15953.202339882959;778.8559116563454;838.6142374507795;838.890944177253;899.4423457456419;923.9815203695888;8672.176143266379;8809.559522024001;8930.955345223363;9033.548322583845;9071.637134514545;338442;340970;357095;369674.1629185407;373480;65252.347476525574;67022.32977670258;67698.32301676921;69711;69875.65062174758;923;930.0885132569985;942.4251206763869;956.0773853231665;956.4643799472318;13685.384157713126;13848;13946.930265349014;13976;14067.507637232648;30348.393032139677;30768.692313076583;31177.220569485944;32111.839440802647;32566.674333256364;42880.57119428766;43061.56938430575;43253;43352.78323608488;43393;6821.317868213139;6942.930570694229;6968.303169683194;7009;7272;10140.645077422254;10272.435016073889;10881.673549793519;11035.117190624891;11185.944070279596;9310.906890931004;9363.85954210701;9514.476703781082;9687.321887468092;9722.951385243028;9502.239820814457;9535.52322383892;9538.713838584854;9595.568199431182;9701.223902087675;9420.811583768424;9612.855807163038;9804.41173529562;9828.11546960777;9976.152027077489;6600.60396376219;6670.966645166744;6754;6786.491013174131;6914.654267286716;7985;9422.246220302497;9592.808143836945;9709;9773.706788796348 09:34:15 INFO - PROCESS | 4518 | |3;mootools.html;1213.3266037349267;1363.9045266831322;1365.870242326979;1474.8598883106108;1710.6664200480902;6878.552894061889;7011.228764835871;7031.3320234577695;7073.787786366404;7084.822879428017;6974.267701891305;7123.465740069502;7142.892856607155;7143.3570978611915;7148;1626.4388785868857;1994.4714650617598;2038.7859274776158;2050.579631175609;2077.40793873746;2079.864808787424;2088.5405210853587;2089.4358523198725;2090.1221486975433;2090.6654935210368;1984.8312893404077;2021.9797802022013;2025.7872923343057;2029.0970518119443;2029.411470673503;1997.4207479830977;2015.4054553906633;2021.7674967378794;2023.1705000949614;2051.4563640635242;2050.333641566482;2063.2778527515397;2064.607724532334;2067.018166370977;2068.524239424941;7171.247019062976;7220.350168484809;7223.747168849065;7224.674889629927;7229.746958856467;4084.673226141931;4199.2441360555085;4209.621134097915;4216.2199993001395;4222.683298752606;2601.2196341097783;2759.4205216904475;2771.7366850149206;2776.54187059135;2782.1097248880365;860.4579115157474;899.6806133822464;905.7011186308503;926.7127190570944;944.617429940875;9857.359271647392;9867.60529578816;9876.308658393915;9878.60485580576;9880.604775808959;3700.296943580765;3713.7771733696063;3779.3952967525065;3784.848606055782;3793;8497.872531912026;8506.702265420681;8509.531975741269;8511.872321915176;8522.87215691765;3536.5932917714276;4145.502539695196;4164.208800327928;4168.062186008185;4175.64507016907;3577.069961809948;3632.3461776880417;3641.817909104534;3643.3624115780162;3658.4695219193068;3108.580341653893;3184.3949649566507;3195.920101997422;3197.4244635965283;3209.3741720364305;974.4153507895348;981.8281800684852;982.0670363155032;986.7681094942683;999.5202302894506;1117.1286396610656;1119.9104071674246;1133.5522468624847;1138.2885696439726;1158.692946369213;6671.132752742113;6722.327767223239;6730.057791909038;6759.695813688396;6766.289539598271;411.2556273145616;416.2465936654665;417.19689597524643;420.42821762403105;421.3448088222843;5037.269595908646;5055.772490237948;5083.898322033612;5100.26046223303;5102.515261050195;8198.959005205055;8428.199321064489;8497.787555311043;8666.739997800076;8677.826443471222;8239.340852731768;8262.628181731836;8277.95861020691;8313.41806073569;8347;6517.771877984248;6582.605043697394;6725.63009034498;6765.458763299022;6772.864542709118;6515.446187074152;6546.672666366758;6601.669916504252;6602.471802255712;6604.273529911802;7491.400687945061;7688.730894418669;7758.844823103619;7761;7881.369490440637;7461.92538074634;7566.848663026819;7666.041744781903;7966.84066318682;8058.516489010678;5284.656497327662;5866.002779527405;6016.278046634432;6073.605215660968;6113.205283313141;6431.163948686641;6474.320196379313;6477.967610161919;6480.125183100221;6483.546151769331;5519.503244707996;5601.915971260353;5619.943800561942;5755.7697692093525;5758.942410575841;5648.124540696199;5730.111832665943;5737.885242295214;5822.097574875901;5824.097264923944;6068.4538391544975;6111.786087486917;6171.475424588781;6229.688515574294;6233.75064997395;5661.490465858093;5692.5445964321925;5755.625884317506;5758.913616295675;5760;5781.248437703071;5815.331236907809;5845.824625261249;5855.619384739978;5878.706064696663 09:34:15 INFO - PROCESS | 4518 | |4;prototype.html;279.3881399734581;286.03178241652006;287.3477206740699;289.4384893306983;293.0388326289769;5244.895102097956;5275.868103297419;5278;5278.0763366410865;5293.947060529394;4988.75056247188;5145.922811157826;5147.408048074472;5149.459306772791;5161.458046905077;3810.0665336992474;3904.863329783458;3967.603239676024;3978.443017977471;3992.9800350998203;4035.7982100894983;4035.9394609080887;4038.374052021941;4038.5153781546255;4039.838406463738;3994.4607477990535;3996.5204175498834;4000.719949603529;4004.899877503057;4008.819603117867;3790.9810450947707;3873.6513713765617;3947.5460322063045;3972.106276087886;4007.499062617173;3449.689527942497;3457.4122399192197;3457.757956943015;3460.602030766469;3464;5031.899362012739;5056.544910957995;5060.165072763027;5067.797288108472;5070.31550740649;4550.408446901882;4567;4567.223571992769;4568.771561421916;4570.377515981845;5458.754356053987;5461.317335333083;5480.04099282624;5481.835544933659;5487.286652735119;3741.3265612189794;3755.455458958436;3755.793431361274;3758.1168425420005;3759.755615884959;5621.100623900156;5669.829905102853;5735.225744524478;5829.242198514208;5845.240118784531;3798.4682144499793;3848.0572259796527;3854.6338097880657;3856.402257650069;3858.78776667286;3898.2593307271527;3913.96086039136;3914.1388894443176;3914.7651140931634;3916.3929590913453;4528.977355113269;4533.54664533544;4539.319102134707;4540.614047805973;4543.045960348364;5469.425710300361;5475.397706252309;5481.862953426116;5482;5482.533984611273;1351.250056218808;1378.400395827818;1379.0829098649285;1380.1650001749;1380.8895288376905;834;874.0691163910415;920.6685593186447;933.071593764209;934.1685899549407;4714.81140754366;4802.351682522884;4805.159097158054;4807.61539076873;4809.062232864558;5636;5738.225339579187;5753.683547404933;5810.825675229666;5810.912836307459;4849.9030019399415;4854.393200849894;4854.490278520704;4856.587190088811;4860.343853579721;3037.832919189422;3074.031680020831;3077.5383692445866;3081.6147981502313;3084.3677046205476;5447.891042179134;5465.234867118606;5477.233187353773;5483.314585676791;5486.31421072366;5681.488666019995;5897.970510147422;5900.881982360414;5901.822945311647;5912.054071348563;5450.073487507133;5458.372287186945;5460.781568737286;5461.1262198048125;5467.917981230285;5727.570432217683;5746.655200687972;5766.279215098113;5801.216835727291;5803.912941305799;5605.32736071674;5608.07466767995;5653.462921022497;5656.2929633795775;5667.744951477276;5414.458554144554;5417.864553386197;5432.972835135799;5459.317585301837;5461.617686761889;3834.0223243072837;3857.765515035162;3966.6628336590557;3973.3245348290284;3982.7212095153063;5589.552835773047;5654.067078932095;5663.3770285267765;5668.404817494104;5668.744906479136;5462.371827239759;5463.48096930791;5464.453554644504;5466.781328746805;5468.125099983983;5449.046416876951;5463.043967305626;5470.097433923358;5470.699111548903;5472.315960504937;5361.463853614763;5369.221462887937;5371.946280537145;5372.677639341652;5379.1662292344745;5433.157860531624;5498.890022199454;5501.229827824028;5508.091164957737;5509.118541033416;5330;5354.7858085676135;5355.410904800547;5358.276632654542;5360.463953604608 09:34:15 INFO - PROCESS | 4518 | |5;yui.html;637.6014990630856;706.5795851468374;708.1219288082779;723.5839392349401;753.2204168685412;10573;10787.137029037678;10842.186835987313;10847.566097356106;10853.837192442119;10760.677179684622;10871.075958543533;10894.727631809208;11110.055645270142;11317.547298108086;600.4535872356134;755.777045771496;761.3072104385011;776.8990031295924;779.1195948578098;763.919788422216;766.5017738470011;766.5553978692345;767.106321135876;767.2787579675088;817.7464985854374;819.2176471469733;819.3404309530855;819.8114433680257;820.216693058128;628.6448156791421;787.9921200787976;802.6749166587541;802.6749166587541;803.1085495100434;594.3996563470882;595.1489370200611;595.7587177193244;596.1802521532892;596.4155127974566;11744.29534227949;11810.527578896834;11830.231034982698;11849.466773995191;11852.34812085335;10987.61543345987;11435.771284574344;11927.284362938164;11978.700532486757;12077.45651445687;9049.864252036159;9104.590293436811;9392.436453812794;9487.335886487948;9503.762405939908;3202.9679703203137;3243.2378391078078;3277.4756039033878;3295.6210035845943;3343.2310568569364;42193.789031054956;42255.57744422547;42282.78858605718;42296.365554516706;42494.93762655927;9370.531473426301;9489.810203795885;9593.992630773808;9712.9028709712;9744.220462362993;16674.66650667004;16718.83281167197;16733.916330418513;16770.077645729358;16777.496675099766;6477.967610161919;6483.2544257411;6568.244651865001;6569;6778.898316525256;3587.5336206293014;3597.244578638515;3644.6173151819207;3711.2577484502667;3743.681787048077;2516.1445108663142;2533.4173140177863;2541.504406640687;2547.5414425403233;2559.5136923984383;446.112236649066;446.15899030328063;454.6135784583144;460.452062046164;462.29500012480565;482.3632804697765;486.23660852462;491.22631854828074;504.38465072611353;510.1149505607768;7170.749023784142;7245.347918687344;7292.635368231568;7397;7487.625618719042;497.1449107535034;549.2694716027673;557.0474488624417;559.8376470823415;569.137756299207;3308.7022168004996;3353.077903576487;3381.4758712399616;3408.9488657670154;3459.619441861393;50442.24336634953;50554;50804.491955079975;52579.21131183035;53724.35894231128;43723.56276437258;44252.557474424844;44533;44789;44918;40392.39411408831;40709;40813;40818.18363632711;41077.1784564307;7619.08570971487;7620.3522700571075;7689.807754806175;7826.726064587712;7979.800504987422;30979;31675.683243167274;31736.523952141197;32015.199620008756;32410.83794581012;38725.41911871268;40301.790946270485;40540;40979.795101024305;41351;9258.861117083114;9689.273304502332;9805.460699661302;10237.471209594167;10450.372977621368;10442.843357349799;10941.398223097805;11261.71845703864;11297.26567773092;11536;10185.388876667424;10352.741181470223;10641.201909856636;10698;10931.398773067558;9752.804943900941;9787.168090712084;9887.802243954937;10082.092611664986;10294.897051029393;10095.343802652804;10257.974202579682;10358.378497290187;10363.689089327332;10639.414832184304;7970.800729981797;8298.253157215879;8424.705135320235;8471.32229421657;8524.147585241426;8315.210055044761;8351.832963340821;8356.623951922056;8380.24577788002;8812.413765522011 09:34:15 INFO - PROCESS | 4518 | __end_tp_report 09:34:15 INFO - PROCESS | 4518 | __start_cc_report 09:34:15 INFO - PROCESS | 4518 | _x_x_mozilla_cycle_collect,900 09:34:15 INFO - PROCESS | 4518 | __end_cc_report 09:34:15 INFO - PROCESS | 4518 | __startTimestamp1456508055306__endTimestamp 09:34:15 INFO - PROCESS | 4518 | 09:34:15 INFO - PROCESS | 4518 | ------- Summary: start ------- 09:34:15 INFO - PROCESS | 4518 | Number of tests: 6 09:34:15 INFO - PROCESS | 4518 | 09:34:15 INFO - PROCESS | 4518 | [#0] dojo.html Cycles:165 Average:4367.90 Median:4503.68 stddev:428.51 (9.5%) stddev-sans-first:406.34 09:34:15 INFO - PROCESS | 4518 | Values: 2584.4 2646.5 2662.2 2669.4 2697.5 4266.2 4362.1 4377.4 4388.0 4402.4 4379.3 4405.7 4434.5 4435.4 4473.1 4016.3 4059.7 4063.8 4101.6 4137.2 4009.7 4069.7 4114.5 4128.3 4144.0 4053.5 4145.4 4163.5 4168.2 4170.2 4094.1 4117.5 4122.9 4153.1 4153.3 3957.2 4071.0 4119.3 4122.1 4162.5 4279.3 4316.1 4380.3 4397.6 4417.1 4660.5 4679.3 4679.4 4686.9 4710.5 4616.1 4691.9 4699.3 4700.3 4745.1 4444.5 4446.0 4448.5 4486.2 4487.4 4860.4 4863.3 4865.1 4866.0 4867.4 4482.2 4592.2 4668.4 4680.8 4719.4 4706.7 4717.5 4732.7 4742.5 4758.7 4663.4 4672.7 4675.4 4683.2 4736.2 4505.8 4556.5 4619.9 4622.6 4640.9 3887.5 3907.8 3922.7 3948.8 3949.7 3487.1 3492.6 3497.0 3528.9 3531.6 3938.2 4008.7 4050.1 4140.7 4142.8 4668.6 4703.5 4710.4 4715.9 4760.4 4071.6 4079.0 4080.1 4111.5 4111.9 4106.6 4169.8 4216.3 4221.5 4246.3 4482.2 4485.3 4503.1 4503.7 4540.2 4533.0 4719.7 4720.6 4721.9 4750.5 4502.7 4547.0 4554.4 4574.9 4599.1 4658.5 4674.1 4676.6 4678.3 4703.2 4573.2 4731.4 4744.1 4747.6 4775.1 4597.1 4601.6 4604.4 4608.9 4647.8 4570.9 4594.7 4603.0 4620.7 4651.3 4406.3 4488.6 4525.2 4528.2 4546.1 4590.5 4608.7 4610.5 4629.4 4643.9 4514.7 4516.1 4516.4 4543.9 4551.2 09:34:15 INFO - PROCESS | 4518 | 09:34:15 INFO - PROCESS | 4518 | [#1] ext.html Cycles:180 Average:40327.13 Median:35518.20 stddev:63172.78 (177.9%) stddev-sans-first:63279.15 09:34:15 INFO - PROCESS | 4518 | Values: 480.9 493.0 511.1 519.1 520.6 25035.4 33700.8 34045.0 34045.1 34136.3 35976.3 36388.8 36454.3 36500.5 36501.8 6870.1 7578.2 7773.4 7776.0 9365.0 9557.6 9737.9 9748.0 9749.1 9749.6 9691.4 9837.0 9841.4 9847.0 9847.9 9654.5 9756.0 9762.1 9765.5 9774.4 9573.3 9714.3 9716.7 9717.3 9990.6 36724.8 37031.8 37063.0 37098.4 37101.0 3140.5 3299.3 3428.2 3605.5 3728.8 27790.4 27824.4 28075.6 28151.7 28479.9 3387.9 3418.7 3445.8 3509.7 3560.5 228629.0 230883.0 231051.0 231236.0 231959.0 52594.7 53230.7 53250.7 53269.2 53305.5 56274.0 57054.1 57063.0 57066.0 57122.0 11034.6 12783.9 13043.5 13152.7 13163.3 8076.5 8230.9 8251.9 9741.6 10053.4 18246.0 18315.8 18350.9 18485.0 18510.2 7313.4 7672.3 7696.1 7713.2 7748.8 822.5 869.8 932.5 941.8 955.7 25002.6 26052.7 26057.3 26093.9 26264.7 947.6 951.9 979.8 1062.1 1104.5 13267.5 13477.8 13505.2 13726.6 13878.2 260225.0 264212.0 265594.0 266204.0 267005.0 45024.0 45754.0 45787.3 45828.1 45840.0 975.5 1079.8 1173.8 1228.6 1237.8 22685.2 22905.1 22947.2 23268.0 23441.0 36022.1 36885.0 36951.1 37024.0 37026.8 227118.0 232197.0 233457.0 233713.0 233742.0 24672.6 29309.0 29324.7 29829.0 39513.8 37826.2 37929.0 38240.2 38684.2 38836.0 34031.3 34772.8 35410.3 35476.1 35764.3 34817.3 35088.0 35111.3 35408.6 35449.6 34524.5 35215.5 35323.3 35450.0 35560.3 29521.9 31732.7 31939.5 32038.5 32214.2 24531.1 24691.0 24790.8 25020.5 26247.9 09:34:15 INFO - PROCESS | 4518 | 09:34:15 INFO - PROCESS | 4518 | [#2] jquery.html Cycles:180 Average:21306.07 Median:4811.67 stddev:58530.22 (1216.4%) stddev-sans-first:58673.22 09:34:15 INFO - PROCESS | 4518 | Values: 329.3 332.3 335.1 336.2 337.0 14317.7 14830.2 14916.4 15304.8 15373.6 8881.7 9247.8 14066.3 14307.0 14315.4 4409.7 4542.3 4549.8 4579.5 4587.9 4532.3 4571.6 4580.2 4588.6 4649.9 4854.5 4960.1 4988.4 4993.6 4994.5 4973.4 5017.6 5031.1 5033.9 5037.2 4497.8 4572.7 4762.4 4767.7 4768.9 11277.9 11289.1 11310.8 11318.5 13682.5 1894.6 1908.9 1918.4 1921.4 1985.6 8572.2 8690.8 8691.8 8748.5 12163.2 1724.6 1780.5 1808.1 1833.6 1845.9 39858.6 47258.8 52783.2 53482.0 54507.5 8569.1 8625.4 8773.6 8915.6 9368.3 11399.9 11426.2 11504.4 11517.7 11524.5 6504.4 6799.4 6801.3 6886.4 6905.7 6598.4 6628.4 6709.7 6716.6 6718.2 3767.0 3776.9 3798.2 3878.9 3983.1 1645.7 1670.4 1685.7 1695.6 1716.6 684.5 848.7 858.4 864.9 967.3 15267.2 15470.4 15558.1 15758.1 15953.2 778.9 838.6 838.9 899.4 924.0 8672.2 8809.6 8931.0 9033.5 9071.6 338442.0 340970.0 357095.0 369674.2 373480.0 65252.3 67022.3 67698.3 69711.0 69875.7 923.0 930.1 942.4 956.1 956.5 13685.4 13848.0 13946.9 13976.0 14067.5 30348.4 30768.7 31177.2 32111.8 32566.7 42880.6 43061.6 43253.0 43352.8 43393.0 6821.3 6942.9 6968.3 7009.0 7272.0 10140.6 10272.4 10881.7 11035.1 11185.9 9310.9 9363.9 9514.5 9687.3 9723.0 9502.2 9535.5 9538.7 9595.6 9701.2 9420.8 9612.9 9804.4 9828.1 9976.2 6600.6 6671.0 6754.0 6786.5 6914.7 7985.0 9422.2 9592.8 9709.0 9773.7 09:34:15 INFO - PROCESS | 4518 | 09:34:15 INFO - PROCESS | 4518 | [#3] mootools.html Cycles:180 Average:4861.80 Median:5818.71 stddev:2594.55 (44.6%) stddev-sans-first:2587.34 09:34:15 INFO - PROCESS | 4518 | Values: 1213.3 1363.9 1365.9 1474.9 1710.7 6878.6 7011.2 7031.3 7073.8 7084.8 6974.3 7123.5 7142.9 7143.4 7148.0 1626.4 1994.5 2038.8 2050.6 2077.4 2079.9 2088.5 2089.4 2090.1 2090.7 1984.8 2022.0 2025.8 2029.1 2029.4 1997.4 2015.4 2021.8 2023.2 2051.5 2050.3 2063.3 2064.6 2067.0 2068.5 7171.2 7220.4 7223.7 7224.7 7229.7 4084.7 4199.2 4209.6 4216.2 4222.7 2601.2 2759.4 2771.7 2776.5 2782.1 860.5 899.7 905.7 926.7 944.6 9857.4 9867.6 9876.3 9878.6 9880.6 3700.3 3713.8 3779.4 3784.8 3793.0 8497.9 8506.7 8509.5 8511.9 8522.9 3536.6 4145.5 4164.2 4168.1 4175.6 3577.1 3632.3 3641.8 3643.4 3658.5 3108.6 3184.4 3195.9 3197.4 3209.4 974.4 981.8 982.1 986.8 999.5 1117.1 1119.9 1133.6 1138.3 1158.7 6671.1 6722.3 6730.1 6759.7 6766.3 411.3 416.2 417.2 420.4 421.3 5037.3 5055.8 5083.9 5100.3 5102.5 8199.0 8428.2 8497.8 8666.7 8677.8 8239.3 8262.6 8278.0 8313.4 8347.0 6517.8 6582.6 6725.6 6765.5 6772.9 6515.4 6546.7 6601.7 6602.5 6604.3 7491.4 7688.7 7758.8 7761.0 7881.4 7461.9 7566.8 7666.0 7966.8 8058.5 5284.7 5866.0 6016.3 6073.6 6113.2 6431.2 6474.3 6478.0 6480.1 6483.5 5519.5 5601.9 5619.9 5755.8 5758.9 5648.1 5730.1 5737.9 5822.1 5824.1 6068.5 6111.8 6171.5 6229.7 6233.8 5661.5 5692.5 5755.6 5758.9 5760.0 5781.2 5815.3 5845.8 5855.6 5878.7 09:34:15 INFO - PROCESS | 4518 | 09:34:15 INFO - PROCESS | 4518 | [#4] prototype.html Cycles:180 Average:4540.91 Median:5260.38 stddev:1358.30 (25.8%) stddev-sans-first:1323.91 09:34:15 INFO - PROCESS | 4518 | Values: 279.4 286.0 287.3 289.4 293.0 5244.9 5275.9 5278.0 5278.1 5293.9 4988.8 5145.9 5147.4 5149.5 5161.5 3810.1 3904.9 3967.6 3978.4 3993.0 4035.8 4035.9 4038.4 4038.5 4039.8 3994.5 3996.5 4000.7 4004.9 4008.8 3791.0 3873.7 3947.5 3972.1 4007.5 3449.7 3457.4 3457.8 3460.6 3464.0 5031.9 5056.5 5060.2 5067.8 5070.3 4550.4 4567.0 4567.2 4568.8 4570.4 5458.8 5461.3 5480.0 5481.8 5487.3 3741.3 3755.5 3755.8 3758.1 3759.8 5621.1 5669.8 5735.2 5829.2 5845.2 3798.5 3848.1 3854.6 3856.4 3858.8 3898.3 3914.0 3914.1 3914.8 3916.4 4529.0 4533.5 4539.3 4540.6 4543.0 5469.4 5475.4 5481.9 5482.0 5482.5 1351.3 1378.4 1379.1 1380.2 1380.9 834.0 874.1 920.7 933.1 934.2 4714.8 4802.4 4805.2 4807.6 4809.1 5636.0 5738.2 5753.7 5810.8 5810.9 4849.9 4854.4 4854.5 4856.6 4860.3 3037.8 3074.0 3077.5 3081.6 3084.4 5447.9 5465.2 5477.2 5483.3 5486.3 5681.5 5898.0 5900.9 5901.8 5912.1 5450.1 5458.4 5460.8 5461.1 5467.9 5727.6 5746.7 5766.3 5801.2 5803.9 5605.3 5608.1 5653.5 5656.3 5667.7 5414.5 5417.9 5433.0 5459.3 5461.6 3834.0 3857.8 3966.7 3973.3 3982.7 5589.6 5654.1 5663.4 5668.4 5668.7 5462.4 5463.5 5464.5 5466.8 5468.1 5449.0 5463.0 5470.1 5470.7 5472.3 5361.5 5369.2 5371.9 5372.7 5379.2 5433.2 5498.9 5501.2 5508.1 5509.1 5330.0 5354.8 5355.4 5358.3 5360.5 09:34:15 INFO - PROCESS | 4518 | 09:34:15 INFO - PROCESS | 4518 | [#5] yui.html Cycles:180 Average:12254.85 Median:22686.31 stddev:14163.62 (62.4%) stddev-sans-first:14176.48 09:34:15 INFO - PROCESS | 4518 | Values: 637.6 706.6 708.1 723.6 753.2 10573.0 10787.1 10842.2 10847.6 10853.8 10760.7 10871.1 10894.7 11110.1 11317.5 600.5 755.8 761.3 776.9 779.1 763.9 766.5 766.6 767.1 767.3 817.7 819.2 819.3 819.8 820.2 628.6 788.0 802.7 802.7 803.1 594.4 595.1 595.8 596.2 596.4 11744.3 11810.5 11830.2 11849.5 11852.3 10987.6 11435.8 11927.3 11978.7 12077.5 9049.9 9104.6 9392.4 9487.3 9503.8 3203.0 3243.2 3277.5 3295.6 3343.2 42193.8 42255.6 42282.8 42296.4 42494.9 9370.5 9489.8 9594.0 9712.9 9744.2 16674.7 16718.8 16733.9 16770.1 16777.5 6478.0 6483.3 6568.2 6569.0 6778.9 3587.5 3597.2 3644.6 3711.3 3743.7 2516.1 2533.4 2541.5 2547.5 2559.5 446.1 446.2 454.6 460.5 462.3 482.4 486.2 491.2 504.4 510.1 7170.7 7245.3 7292.6 7397.0 7487.6 497.1 549.3 557.0 559.8 569.1 3308.7 3353.1 3381.5 3408.9 3459.6 50442.2 50554.0 50804.5 52579.2 53724.4 43723.6 44252.6 44533.0 44789.0 44918.0 40392.4 40709.0 40813.0 40818.2 41077.2 7619.1 7620.4 7689.8 7826.7 7979.8 30979.0 31675.7 31736.5 32015.2 32410.8 38725.4 40301.8 40540.0 40979.8 41351.0 9258.9 9689.3 9805.5 10237.5 10450.4 10442.8 10941.4 11261.7 11297.3 11536.0 10185.4 10352.7 10641.2 10698.0 10931.4 9752.8 9787.2 9887.8 10082.1 10294.9 10095.3 10258.0 10358.4 10363.7 10639.4 7970.8 8298.3 8424.7 8471.3 8524.1 8315.2 8351.8 8356.6 8380.2 8812.4 09:34:15 INFO - PROCESS | 4518 | -------- Summary: end -------- 09:34:15 INFO - PROCESS | 4518 | 09:34:16 INFO - TEST-INFO | 4518: exit 0 09:34:16 INFO - TEST-OK | dromaeo_css | took 1116161ms 09:34:16 INFO - TEST-START | kraken 09:34:16 INFO - operating with platform_type : linux_ 09:34:16 INFO - Initialising browser for kraken test... 09:34:16 INFO - TEST-INFO | started process 4701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXzKSJy/profile http://localhost:45556/getInfo.html) 09:34:20 INFO - PROCESS | 4701 | __metrics Screen width/height:1600/1200 09:34:20 INFO - PROCESS | 4701 | colorDepth:24 09:34:20 INFO - PROCESS | 4701 | Browser inner width/height: 1024/697 09:34:20 INFO - PROCESS | 4701 | __metrics 09:34:20 INFO - PROCESS | 4701 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:21 INFO - TEST-INFO | 4701: exit 0 09:34:21 INFO - Browser initialized. 09:34:21 INFO - Running cycle 1/1 for kraken test... 09:34:21 INFO - TEST-INFO | started process 4784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXzKSJy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:33 INFO - PROCESS | 4784 | RSS: Main: 147898368 09:34:33 INFO - PROCESS | 4784 | 09:34:36 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45556/tests/kraken/driver.html?testName=audio-beat-detection) 09:34:37 INFO - PROCESS | 4784 | RSS: Main: 193646592 09:34:37 INFO - PROCESS | 4784 | 09:34:39 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45556/tests/kraken/driver.html?testName=audio-dft) 09:34:40 INFO - PROCESS | 4784 | RSS: Main: 180617216 09:34:40 INFO - PROCESS | 4784 | 09:34:43 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45556/tests/kraken/driver.html?testName=audio-fft) 09:34:44 INFO - PROCESS | 4784 | RSS: Main: 167964672 09:34:44 INFO - PROCESS | 4784 | 09:34:46 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45556/tests/kraken/driver.html?testName=audio-oscillator) 09:34:46 INFO - PROCESS | 4784 | RSS: Main: 168185856 09:34:46 INFO - PROCESS | 4784 | 09:34:49 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45556/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:34:49 INFO - PROCESS | 4784 | RSS: Main: 168468480 09:34:49 INFO - PROCESS | 4784 | 09:34:52 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45556/tests/kraken/driver.html?testName=imaging-darkroom) 09:34:53 INFO - PROCESS | 4784 | RSS: Main: 170790912 09:34:53 INFO - PROCESS | 4784 | 09:34:56 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45556/tests/kraken/driver.html?testName=imaging-desaturate) 09:34:57 INFO - PROCESS | 4784 | RSS: Main: 171692032 09:34:57 INFO - PROCESS | 4784 | 09:35:00 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45556/tests/kraken/driver.html?testName=json-parse-financial) 09:35:00 INFO - PROCESS | 4784 | RSS: Main: 172154880 09:35:00 INFO - PROCESS | 4784 | 09:35:02 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45556/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:03 INFO - PROCESS | 4784 | RSS: Main: 181895168 09:35:03 INFO - PROCESS | 4784 | 09:35:05 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45556/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:05 INFO - PROCESS | 4784 | RSS: Main: 180121600 09:35:05 INFO - PROCESS | 4784 | 09:35:07 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45556/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:08 INFO - PROCESS | 4784 | RSS: Main: 191328256 09:35:08 INFO - PROCESS | 4784 | 09:35:10 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:11 INFO - PROCESS | 4784 | RSS: Main: 196128768 09:35:11 INFO - PROCESS | 4784 | 09:35:14 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:14 INFO - PROCESS | 4784 | RSS: Main: 195231744 09:35:14 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | Cycle 1(1): loaded http://localhost:45556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45556/tests/kraken/driver.html?testName=ai-astar) 09:35:16 INFO - PROCESS | 4784 | RSS: Main: 254640128 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | __start_tp_report 09:35:16 INFO - PROCESS | 4784 | _x_x_mozilla_page_load 09:35:16 INFO - PROCESS | 4784 | _x_x_mozilla_page_load_details 09:35:16 INFO - PROCESS | 4784 | |i|pagename|runs| 09:35:16 INFO - PROCESS | 4784 | |0;ai-astar;113;115;111;114;114;114;105;114;115;116 09:35:16 INFO - PROCESS | 4784 | |1;audio-beat-detection;153;132;154;172;133;157;152;133;175;133 09:35:16 INFO - PROCESS | 4784 | |2;audio-dft;162;159;162;161;160;161;162;161;162;160 09:35:16 INFO - PROCESS | 4784 | |3;audio-fft;75;75;102;95;73;73;75;113;94;74 09:35:16 INFO - PROCESS | 4784 | |4;audio-oscillator;99;98;142;98;98;98;144;97;99;143 09:35:16 INFO - PROCESS | 4784 | |5;imaging-gaussian-blur;119;116;115;116;115;115;115;114;115;114 09:35:16 INFO - PROCESS | 4784 | |6;imaging-darkroom;147;148;147;149;147;149;150;148;147;148 09:35:16 INFO - PROCESS | 4784 | |7;imaging-desaturate;96;97;96;97;97;97;96;97;97;96 09:35:16 INFO - PROCESS | 4784 | |8;json-parse-financial;67;66;76;67;65;66;67;77;64;65 09:35:16 INFO - PROCESS | 4784 | |9;json-stringify-tinderbox;81;71;71;71;71;72;76;72;71;71 09:35:16 INFO - PROCESS | 4784 | |10;stanford-crypto-aes;89;91;89;86;94;85;87;86;86;88 09:35:16 INFO - PROCESS | 4784 | |11;stanford-crypto-ccm;123;134;128;119;127;124;121;121;122;124 09:35:16 INFO - PROCESS | 4784 | |12;stanford-crypto-pbkdf2;154;146;153;153;162;140;151;149;151;152 09:35:16 INFO - PROCESS | 4784 | |13;stanford-crypto-sha256-iterative;72;75;72;73;75;73;71;71;71;71 09:35:16 INFO - PROCESS | 4784 | __end_tp_report 09:35:16 INFO - PROCESS | 4784 | __start_cc_report 09:35:16 INFO - PROCESS | 4784 | _x_x_mozilla_cycle_collect,1177 09:35:16 INFO - PROCESS | 4784 | __end_cc_report 09:35:16 INFO - PROCESS | 4784 | __startTimestamp1456508116942__endTimestamp 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | ------- Summary: start ------- 09:35:16 INFO - PROCESS | 4784 | Number of tests: 14 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.14 (2.8%) stddev-sans-first:3.33 09:35:16 INFO - PROCESS | 4784 | Values: 113.0 115.0 111.0 114.0 114.0 114.0 105.0 114.0 115.0 116.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:153.50 stddev:16.24 (10.6%) stddev-sans-first:17.18 09:35:16 INFO - PROCESS | 4784 | Values: 153.0 132.0 154.0 172.0 133.0 157.0 152.0 133.0 175.0 133.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.05 09:35:16 INFO - PROCESS | 4784 | Values: 162.0 159.0 162.0 161.0 160.0 161.0 162.0 161.0 162.0 160.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#3] audio-fft Cycles:10 Average:84.90 Median:75.00 stddev:14.77 (19.7%) stddev-sans-first:15.22 09:35:16 INFO - PROCESS | 4784 | Values: 75.0 75.0 102.0 95.0 73.0 73.0 75.0 113.0 94.0 74.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:98.00 stddev:21.68 (22.1%) stddev-sans-first:22.51 09:35:16 INFO - PROCESS | 4784 | Values: 99.0 98.0 142.0 98.0 98.0 98.0 144.0 97.0 99.0 143.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.43 (1.2%) stddev-sans-first:0.71 09:35:16 INFO - PROCESS | 4784 | Values: 119.0 116.0 115.0 116.0 115.0 115.0 115.0 114.0 115.0 114.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 09:35:16 INFO - PROCESS | 4784 | Values: 147.0 148.0 147.0 149.0 147.0 149.0 150.0 148.0 147.0 148.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:35:16 INFO - PROCESS | 4784 | Values: 96.0 97.0 96.0 97.0 97.0 97.0 96.0 97.0 97.0 96.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:67.00 stddev:4.59 (6.9%) stddev-sans-first:4.86 09:35:16 INFO - PROCESS | 4784 | Values: 67.0 66.0 76.0 67.0 65.0 66.0 67.0 77.0 64.0 65.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:71.50 stddev:3.30 (4.6%) stddev-sans-first:1.64 09:35:16 INFO - PROCESS | 4784 | Values: 81.0 71.0 71.0 71.0 71.0 72.0 76.0 72.0 71.0 71.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.50 stddev:2.77 (3.1%) stddev-sans-first:2.92 09:35:16 INFO - PROCESS | 4784 | Values: 89.0 91.0 89.0 86.0 94.0 85.0 87.0 86.0 86.0 88.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:124.00 stddev:4.37 (3.5%) stddev-sans-first:4.61 09:35:16 INFO - PROCESS | 4784 | Values: 123.0 134.0 128.0 119.0 127.0 124.0 121.0 121.0 122.0 124.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:152.50 stddev:5.67 (3.7%) stddev-sans-first:5.91 09:35:16 INFO - PROCESS | 4784 | Values: 154.0 146.0 153.0 153.0 162.0 140.0 151.0 149.0 151.0 152.0 09:35:16 INFO - PROCESS | 4784 | 09:35:16 INFO - PROCESS | 4784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:72.50 stddev:1.58 (2.2%) stddev-sans-first:1.67 09:35:16 INFO - PROCESS | 4784 | Values: 72.0 75.0 72.0 73.0 75.0 73.0 71.0 71.0 71.0 71.0 09:35:16 INFO - PROCESS | 4784 | -------- Summary: end -------- 09:35:16 INFO - PROCESS | 4784 | 09:35:17 INFO - TEST-INFO | 4784: exit 0 09:35:17 INFO - TEST-OK | kraken | took 61927ms 09:35:17 INFO - SUITE-END | took 1178s 09:35:18 INFO - Completed test suite (00:19:38) 09:35:18 INFO - Working with test: dromaeo_css 09:35:18 INFO - Generating results file: dromaeo_css 09:35:18 INFO - Working with test: kraken 09:35:18 INFO - Generating results file: kraken 09:35:18 INFO - javascript benchmark 09:35:18 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:35:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:35:18 INFO - process_Request line: dromaeo_css 6037.02 graph.html#tests=[[72,132,35]] 09:35:18 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:35:18 INFO - process_Request line: kraken 1556.60 graph.html#tests=[[232,132,35]] 09:35:18 INFO - RETURN: dromaeo_css: 6037.02 09:35:18 INFO - RETURN: kraken: 1556.60 09:35:18 INFO - javascript benchmark 09:35:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2584.3926677230847, 2646.5103955768172, 2662.227953893371, 2669.3860412105214, 2697.473992571448, 4266.189424009436, 4362.083962367902, 4377.365282034103, 4387.978060109699, 4402.427684401027, 4379.255526560484, 4405.6695747818885, 4434.467863856342, 4435.423394958659, 4473.060657261971, 4016.2971479990883, 4059.654929330996, 4063.7968101594874, 4101.569335219789, 4137.151883863816, 4009.719319647626, 4069.7151199416053, 4114.485689288839, 4128.339465685491, 4144.026153853842, 4053.4730485037053, 4145.440365550642, 4163.542010378856, 4168.187203495319, 4170.16596680662, 4094.0583665757044, 4117.547069822317, 4122.9381559276635, 4153.127843152942, 4153.273177193979, 3957.168994511156, 4070.979645101785, 4119.340905455113, 4122.113745544692, 4162.500499939996, 4279.315309550457, 4316.072044510414, 4380.277254253045, 4397.5602439756085, 4417.050334178135, 4660.487346391894, 4679.27471241958, 4679.438467383936, 4686.929696054562, 4710.5289471052965, 4616.053708989649, 4691.906161876777, 4699.271612900006, 4700.320817134235, 4745.074710431467, 4444.511103778582, 4446.0, 4448.466184057934, 4486.192485352668, 4487.416635837386, 4860.392450943632, 4863.270509423544, 4865.1242776300605, 4865.95134048662, 4867.3915760529935, 4482.1707984022405, 4592.242280023758, 4668.369770080995, 4680.789364478606, 4719.433667959866, 4706.717596944194, 4717.481077081518, 4732.716037037789, 4742.549457801503, 4758.714477131383, 4663.440387153563, 4672.672912896132, 4675.368825208621, 4683.157031734252, 4736.194846876039, 4505.774711264424, 4556.476005259371, 4619.884502887455, 4622.560856718606, 4640.883977900579, 3887.455756194135, 3907.8241479133508, 3922.7057970652313, 3948.763074215556, 3949.743266687656, 3487.128217945514, 3492.5808902931813, 3497.0208341664375, 3528.894133176009, 3531.6291789362263, 3938.1729836734035, 4008.659263962596, 4050.10897602527, 4140.668746500272, 4142.813573389205, 4668.5798278155125, 4703.529647035338, 4710.387649605529, 4715.905681886343, 4760.357351757469, 4071.5521292657786, 4079.0, 4080.10237747695, 4111.465509483808, 4111.8560850370095, 4106.630403263721, 4169.812358443877, 4216.3464662977285, 4221.514525829508, 4246.320588705792, 4482.238019536621, 4485.304777759453, 4503.144402563503, 4503.684742068024, 4540.205464043779, 4533.0, 4719.716816990992, 4720.575148236675, 4721.929171062506, 4750.548697873696, 4502.729836209838, 4546.977265113654, 4554.362389265571, 4574.931376029295, 4599.126166028444, 4658.510856360033, 4674.11191873543, 4676.625869930329, 4678.345031695633, 4703.247480403256, 4573.199690054294, 4731.384919960383, 4744.1460537102275, 4747.64392670558, 4775.116603428377, 4597.057603191404, 4601.608863246662, 4604.378408914888, 4608.88477788058, 4647.814087436464, 4570.862874113782, 4594.678372514026, 4602.951860587747, 4620.722756634613, 4651.325557794168, 4406.339049142654, 4488.640908727229, 4525.230710779241, 4528.230200865795, 4546.1135078659345, 4590.517995610413, 4608.746518941491, 4610.5389461054965, 4629.375034370317, 4643.930341044955, 4514.706544074625, 4516.074204788077, 4516.390287311171, 4543.863684089482, 4551.203539380661], "unit": "score", "name": "dojo.html", "value": 4343.175768499482}, {"lowerIsBetter": false, "replicates": [480.92305231163, 493.01889240411595, 511.1106674386566, 519.0708631549526, 520.6069417589721, 25035.37411564712, 33700.83149584252, 34045.0, 34045.14887127817, 34136.317273654546, 35976.280474390565, 36388.81805590968, 36454.27091458169, 36500.45249321256, 36501.817490912574, 6870.141232345957, 7578.204288549692, 7773.416993725465, 7776.027996500437, 9365.0, 9557.61769529218, 9737.853932191023, 9748.0, 9749.122578967892, 9749.610015599403, 9691.370060946016, 9837.0, 9841.36031157976, 9847.0, 9847.901520984806, 9654.5172741363, 9755.951220243853, 9762.072603102764, 9765.462899540522, 9774.364666296739, 9573.329866909318, 9714.271429642806, 9716.708498744978, 9717.271204659608, 9990.550425230882, 36724.81637591795, 37031.814840925894, 37063.0, 37098.443523347174, 37101.0, 3140.4661207594763, 3299.307145499448, 3428.160100775301, 3605.47720580517, 3728.7762734236035, 27790.444191116065, 27824.443511129866, 28075.57886631702, 28151.718482815115, 28479.857600711865, 3387.9491807622903, 3418.7265018798685, 3445.776024558396, 3509.7367697422796, 3560.5015297858063, 228629.0, 230883.0, 231051.0, 231235.9999999983, 231959.0, 52594.737026315386, 53230.73384633052, 53250.73374633102, 53269.2009619856, 53305.46694533005, 56274.0, 57054.14418783721, 57063.0, 57066.00806915297, 57122.0, 11034.613788517363, 12783.936080319725, 13043.543475978295, 13152.736945261042, 13163.276019819003, 8076.4750291230885, 8230.917690823015, 8251.917480825115, 9741.561629726679, 10053.447060411747, 18246.0, 18315.816841831678, 18350.908245458686, 18485.0, 18510.16704248312, 7313.414926805843, 7672.271134242238, 7696.076470823425, 7713.19011503784, 7748.7675369739, 822.4530687093016, 869.8434281829332, 932.5337331334333, 941.7975135345933, 955.7467271173144, 25002.624960625606, 26052.73947260541, 26057.348566285993, 26093.869530652606, 26264.737352626613, 947.6446332625266, 951.9476428796482, 979.7648564344648, 1062.102523367753, 1104.47537419725, 13267.469301227842, 13477.817820305703, 13505.189688618715, 13726.588202353945, 13878.236696981763, 260225.0, 264212.0, 265594.0, 266204.0, 267005.0, 45024.0, 45754.0, 45787.31319030217, 45828.08343833105, 45840.0, 975.492743773234, 1079.8002369561657, 1173.8180582009802, 1228.5577192210797, 1237.8205160251894, 22685.2060177893, 22905.08379664795, 22947.196848110238, 23268.0, 23441.0, 36022.099447514025, 36885.0, 36951.076223094635, 37024.0, 37026.814865925495, 227118.0, 232197.0, 233457.0, 233713.0, 233742.0, 24672.629910550997, 29308.97418590339, 29324.706752932198, 29829.0, 39513.802430987664, 37826.24347513089, 37929.0, 38240.23519529538, 38684.22631547297, 38836.0, 34031.31937361189, 34772.82613586916, 35410.291794164485, 35476.113097172776, 35764.284714306086, 34817.30365392729, 35088.0, 35111.297774044884, 35408.645913541564, 35449.645503544634, 34524.48213276853, 35215.47176792401, 35323.29353412969, 35450.0, 35560.288794224485, 29521.852390738768, 31732.682673173895, 31939.520907186874, 32038.519422209152, 32214.19464513406, 24531.14141005056, 24691.0, 24790.752092478844, 25020.499590007734, 26247.86876065684], "unit": "score", "name": "ext.html", "value": 17005.12167324317}, {"lowerIsBetter": false, "replicates": [329.2838077182128, 332.2723236112913, 335.14872224549646, 336.1562478179768, 336.9561956945598, 14317.72238874339, 14830.184339861304, 14916.403343866246, 15304.84695153048, 15373.615659608515, 8881.733547993554, 9247.768805779859, 14066.296685165751, 14307.0, 14315.355808988594, 4409.7354158750495, 4542.250528662767, 4549.795259213327, 4579.542045795427, 4587.8623641290815, 4532.297493888453, 4571.5657012583915, 4580.221362368388, 4588.609968152711, 4649.930251046237, 4854.490278520758, 4960.057589058068, 4988.376452943382, 4993.5755460785695, 4994.525520075587, 4973.4280557735965, 5017.5985921126585, 5031.094403007457, 5033.899322013557, 5037.19404895215, 4497.820087196508, 4572.657050721209, 4762.38089048425, 4767.713937163781, 4768.856934291976, 11277.943610281896, 11289.0968722502, 11310.773784524346, 11318.547258109666, 13682.452701892013, 1894.6494898443832, 1908.8663793534458, 1918.3957053528095, 1921.3851567498407, 1985.553250518636, 8572.185642363966, 8690.782730431727, 8691.782705432352, 8748.475091494467, 12163.209391389531, 1724.5688577855535, 1780.5459607800058, 1808.095952023988, 1833.5507800588807, 1845.8515478854563, 39858.60141398578, 47258.76370618159, 52783.208251876255, 53482.0, 54507.454925450635, 8569.143085691381, 8625.439346442461, 8773.649054037767, 8915.643374264957, 9368.2973776967, 11399.886001140048, 11426.200165988468, 11504.424778761197, 11517.654470365902, 11524.481398337095, 6504.447121994589, 6799.388055074968, 6801.285864984205, 6886.380225779704, 6905.654717264117, 6598.37315455031, 6628.403443689995, 6709.7316107355155, 6716.5634233774645, 6718.160229971254, 3766.981165094157, 3776.8866933992026, 3798.210735586481, 3878.864239751595, 3983.143624120828, 1645.7284548049677, 1670.4237038221795, 1685.679720853034, 1695.5930576661758, 1716.5794380376637, 684.4558575932145, 848.7284069097952, 858.3818905265056, 864.9264812491009, 967.2697113679127, 15267.23663816827, 15470.381184752483, 15558.079977678812, 15758.133302668462, 15953.202339882959, 778.8559116563454, 838.6142374507795, 838.890944177253, 899.4423457456419, 923.9815203695888, 8672.176143266379, 8809.559522024001, 8930.955345223363, 9033.548322583845, 9071.637134514545, 338442.0, 340970.0, 357095.0, 369674.1629185407, 373480.0, 65252.347476525574, 67022.32977670258, 67698.32301676921, 69711.0, 69875.65062174758, 923.0, 930.0885132569985, 942.4251206763869, 956.0773853231665, 956.4643799472318, 13685.384157713126, 13848.0, 13946.930265349014, 13976.0, 14067.507637232648, 30348.393032139677, 30768.692313076583, 31177.220569485944, 32111.839440802647, 32566.674333256364, 42880.57119428766, 43061.56938430575, 43253.0, 43352.78323608488, 43393.0, 6821.317868213139, 6942.930570694229, 6968.303169683194, 7009.0, 7272.0, 10140.645077422254, 10272.435016073889, 10881.673549793519, 11035.117190624891, 11185.944070279596, 9310.906890931004, 9363.85954210701, 9514.476703781082, 9687.321887468092, 9722.951385243028, 9502.239820814457, 9535.52322383892, 9538.713838584854, 9595.568199431182, 9701.223902087675, 9420.811583768424, 9612.855807163038, 9804.41173529562, 9828.11546960777, 9976.152027077489, 6600.60396376219, 6670.966645166744, 6754.0, 6786.491013174131, 6914.654267286716, 7985.0, 9422.246220302497, 9592.808143836945, 9709.0, 9773.706788796348], "unit": "score", "name": "jquery.html", "value": 7344.36014323966}, {"lowerIsBetter": false, "replicates": [1213.3266037349267, 1363.9045266831322, 1365.870242326979, 1474.8598883106108, 1710.6664200480902, 6878.552894061889, 7011.228764835871, 7031.3320234577695, 7073.787786366404, 7084.822879428017, 6974.267701891305, 7123.465740069502, 7142.892856607155, 7143.3570978611915, 7148.0, 1626.4388785868857, 1994.4714650617598, 2038.7859274776158, 2050.579631175609, 2077.40793873746, 2079.864808787424, 2088.5405210853587, 2089.4358523198725, 2090.1221486975433, 2090.6654935210368, 1984.8312893404077, 2021.9797802022013, 2025.7872923343057, 2029.0970518119443, 2029.411470673503, 1997.4207479830977, 2015.4054553906633, 2021.7674967378794, 2023.1705000949614, 2051.4563640635242, 2050.333641566482, 2063.2778527515397, 2064.607724532334, 2067.018166370977, 2068.524239424941, 7171.247019062976, 7220.350168484809, 7223.747168849065, 7224.674889629927, 7229.746958856467, 4084.673226141931, 4199.2441360555085, 4209.621134097915, 4216.2199993001395, 4222.683298752606, 2601.2196341097783, 2759.4205216904475, 2771.7366850149206, 2776.54187059135, 2782.1097248880365, 860.4579115157474, 899.6806133822464, 905.7011186308503, 926.7127190570944, 944.617429940875, 9857.359271647392, 9867.60529578816, 9876.308658393915, 9878.60485580576, 9880.604775808959, 3700.296943580765, 3713.7771733696063, 3779.3952967525065, 3784.848606055782, 3793.0, 8497.872531912026, 8506.702265420681, 8509.531975741269, 8511.872321915176, 8522.87215691765, 3536.5932917714276, 4145.502539695196, 4164.208800327928, 4168.062186008185, 4175.64507016907, 3577.069961809948, 3632.3461776880417, 3641.817909104534, 3643.3624115780162, 3658.4695219193068, 3108.580341653893, 3184.3949649566507, 3195.920101997422, 3197.4244635965283, 3209.3741720364305, 974.4153507895348, 981.8281800684852, 982.0670363155032, 986.7681094942683, 999.5202302894506, 1117.1286396610656, 1119.9104071674246, 1133.5522468624847, 1138.2885696439726, 1158.692946369213, 6671.132752742113, 6722.327767223239, 6730.057791909038, 6759.695813688396, 6766.289539598271, 411.2556273145616, 416.2465936654665, 417.19689597524643, 420.42821762403105, 421.3448088222843, 5037.269595908646, 5055.772490237948, 5083.898322033612, 5100.26046223303, 5102.515261050195, 8198.959005205055, 8428.199321064489, 8497.787555311043, 8666.739997800076, 8677.826443471222, 8239.340852731768, 8262.628181731836, 8277.95861020691, 8313.41806073569, 8347.0, 6517.771877984248, 6582.605043697394, 6725.63009034498, 6765.458763299022, 6772.864542709118, 6515.446187074152, 6546.672666366758, 6601.669916504252, 6602.471802255712, 6604.273529911802, 7491.400687945061, 7688.730894418669, 7758.844823103619, 7761.0, 7881.369490440637, 7461.92538074634, 7566.848663026819, 7666.041744781903, 7966.84066318682, 8058.516489010678, 5284.656497327662, 5866.002779527405, 6016.278046634432, 6073.605215660968, 6113.205283313141, 6431.163948686641, 6474.320196379313, 6477.967610161919, 6480.125183100221, 6483.546151769331, 5519.503244707996, 5601.915971260353, 5619.943800561942, 5755.7697692093525, 5758.942410575841, 5648.124540696199, 5730.111832665943, 5737.885242295214, 5822.097574875901, 5824.097264923944, 6068.4538391544975, 6111.786087486917, 6171.475424588781, 6229.688515574294, 6233.75064997395, 5661.490465858093, 5692.5445964321925, 5755.625884317506, 5758.913616295675, 5760.0, 5781.248437703071, 5815.331236907809, 5845.824625261249, 5855.619384739978, 5878.706064696663], "unit": "score", "name": "mootools.html", "value": 3906.860067033283}, {"lowerIsBetter": false, "replicates": [279.3881399734581, 286.03178241652006, 287.3477206740699, 289.4384893306983, 293.0388326289769, 5244.895102097956, 5275.868103297419, 5278.0, 5278.0763366410865, 5293.947060529394, 4988.75056247188, 5145.922811157826, 5147.408048074472, 5149.459306772791, 5161.458046905077, 3810.0665336992474, 3904.863329783458, 3967.603239676024, 3978.443017977471, 3992.9800350998203, 4035.7982100894983, 4035.9394609080887, 4038.374052021941, 4038.5153781546255, 4039.838406463738, 3994.4607477990535, 3996.5204175498834, 4000.719949603529, 4004.899877503057, 4008.819603117867, 3790.9810450947707, 3873.6513713765617, 3947.5460322063045, 3972.106276087886, 4007.499062617173, 3449.689527942497, 3457.4122399192197, 3457.757956943015, 3460.602030766469, 3464.0, 5031.899362012739, 5056.544910957995, 5060.165072763027, 5067.797288108472, 5070.31550740649, 4550.408446901882, 4567.0, 4567.223571992769, 4568.771561421916, 4570.377515981845, 5458.754356053987, 5461.317335333083, 5480.04099282624, 5481.835544933659, 5487.286652735119, 3741.3265612189794, 3755.455458958436, 3755.793431361274, 3758.1168425420005, 3759.755615884959, 5621.100623900156, 5669.829905102853, 5735.225744524478, 5829.242198514208, 5845.240118784531, 3798.4682144499793, 3848.0572259796527, 3854.6338097880657, 3856.402257650069, 3858.78776667286, 3898.2593307271527, 3913.96086039136, 3914.1388894443176, 3914.7651140931634, 3916.3929590913453, 4528.977355113269, 4533.54664533544, 4539.319102134707, 4540.614047805973, 4543.045960348364, 5469.425710300361, 5475.397706252309, 5481.862953426116, 5482.0, 5482.533984611273, 1351.250056218808, 1378.400395827818, 1379.0829098649285, 1380.1650001749, 1380.8895288376905, 834.0, 874.0691163910415, 920.6685593186447, 933.071593764209, 934.1685899549407, 4714.81140754366, 4802.351682522884, 4805.159097158054, 4807.61539076873, 4809.062232864558, 5636.0, 5738.225339579187, 5753.683547404933, 5810.825675229666, 5810.912836307459, 4849.9030019399415, 4854.393200849894, 4854.490278520704, 4856.587190088811, 4860.343853579721, 3037.832919189422, 3074.031680020831, 3077.5383692445866, 3081.6147981502313, 3084.3677046205476, 5447.891042179134, 5465.234867118606, 5477.233187353773, 5483.314585676791, 5486.31421072366, 5681.488666019995, 5897.970510147422, 5900.881982360414, 5901.822945311647, 5912.054071348563, 5450.073487507133, 5458.372287186945, 5460.781568737286, 5461.1262198048125, 5467.917981230285, 5727.570432217683, 5746.655200687972, 5766.279215098113, 5801.216835727291, 5803.912941305799, 5605.32736071674, 5608.07466767995, 5653.462921022497, 5656.2929633795775, 5667.744951477276, 5414.458554144554, 5417.864553386197, 5432.972835135799, 5459.317585301837, 5461.617686761889, 3834.0223243072837, 3857.765515035162, 3966.6628336590557, 3973.3245348290284, 3982.7212095153063, 5589.552835773047, 5654.067078932095, 5663.3770285267765, 5668.404817494104, 5668.744906479136, 5462.371827239759, 5463.48096930791, 5464.453554644504, 5466.781328746805, 5468.125099983983, 5449.046416876951, 5463.043967305626, 5470.097433923358, 5470.699111548903, 5472.315960504937, 5361.463853614763, 5369.221462887937, 5371.946280537145, 5372.677639341652, 5379.1662292344745, 5433.157860531624, 5498.890022199454, 5501.229827824028, 5508.091164957737, 5509.118541033416, 5330.0, 5354.7858085676135, 5355.410904800547, 5358.276632654542, 5360.463953604608], "unit": "score", "name": "prototype.html", "value": 4096.734550035031}, {"lowerIsBetter": false, "replicates": [637.6014990630856, 706.5795851468374, 708.1219288082779, 723.5839392349401, 753.2204168685412, 10573.0, 10787.137029037678, 10842.186835987313, 10847.566097356106, 10853.837192442119, 10760.677179684622, 10871.075958543533, 10894.727631809208, 11110.055645270142, 11317.547298108086, 600.4535872356134, 755.777045771496, 761.3072104385011, 776.8990031295924, 779.1195948578098, 763.919788422216, 766.5017738470011, 766.5553978692345, 767.106321135876, 767.2787579675088, 817.7464985854374, 819.2176471469733, 819.3404309530855, 819.8114433680257, 820.216693058128, 628.6448156791421, 787.9921200787976, 802.6749166587541, 802.6749166587541, 803.1085495100434, 594.3996563470882, 595.1489370200611, 595.7587177193244, 596.1802521532892, 596.4155127974566, 11744.29534227949, 11810.527578896834, 11830.231034982698, 11849.466773995191, 11852.34812085335, 10987.61543345987, 11435.771284574344, 11927.284362938164, 11978.700532486757, 12077.45651445687, 9049.864252036159, 9104.590293436811, 9392.436453812794, 9487.335886487948, 9503.762405939908, 3202.9679703203137, 3243.2378391078078, 3277.4756039033878, 3295.6210035845943, 3343.2310568569364, 42193.789031054956, 42255.57744422547, 42282.78858605718, 42296.365554516706, 42494.93762655927, 9370.531473426301, 9489.810203795885, 9593.992630773808, 9712.9028709712, 9744.220462362993, 16674.66650667004, 16718.83281167197, 16733.916330418513, 16770.077645729358, 16777.496675099766, 6477.967610161919, 6483.2544257411, 6568.244651865001, 6569.0, 6778.898316525256, 3587.5336206293014, 3597.244578638515, 3644.6173151819207, 3711.2577484502667, 3743.681787048077, 2516.1445108663142, 2533.4173140177863, 2541.504406640687, 2547.5414425403233, 2559.5136923984383, 446.112236649066, 446.15899030328063, 454.6135784583144, 460.452062046164, 462.29500012480565, 482.3632804697765, 486.23660852462, 491.22631854828074, 504.38465072611353, 510.1149505607768, 7170.749023784142, 7245.347918687344, 7292.635368231568, 7397.0, 7487.625618719042, 497.1449107535034, 549.2694716027673, 557.0474488624417, 559.8376470823415, 569.137756299207, 3308.7022168004996, 3353.077903576487, 3381.4758712399616, 3408.9488657670154, 3459.619441861393, 50442.24336634953, 50554.0, 50804.491955079975, 52579.21131183035, 53724.35894231128, 43723.56276437258, 44252.557474424844, 44533.0, 44789.0, 44918.0, 40392.39411408831, 40709.0, 40813.0, 40818.18363632711, 41077.1784564307, 7619.08570971487, 7620.3522700571075, 7689.807754806175, 7826.726064587712, 7979.800504987422, 30979.0, 31675.683243167274, 31736.523952141197, 32015.199620008756, 32410.83794581012, 38725.41911871268, 40301.790946270485, 40540.0, 40979.795101024305, 41351.0, 9258.861117083114, 9689.273304502332, 9805.460699661302, 10237.471209594167, 10450.372977621368, 10442.843357349799, 10941.398223097805, 11261.71845703864, 11297.26567773092, 11536.0, 10185.388876667424, 10352.741181470223, 10641.201909856636, 10698.0, 10931.398773067558, 9752.804943900941, 9787.168090712084, 9887.802243954937, 10082.092611664986, 10294.897051029393, 10095.343802652804, 10257.974202579682, 10358.378497290187, 10363.689089327332, 10639.414832184304, 7970.800729981797, 8298.253157215879, 8424.705135320235, 8471.32229421657, 8524.147585241426, 8315.210055044761, 8351.832963340821, 8356.623951922056, 8380.24577788002, 8812.413765522011], "unit": "score", "name": "yui.html", "value": 5575.452528195056}], "name": "dromaeo_css", "value": 6037.018416473391}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 111.0, 114.0, 114.0, 114.0, 105.0, 114.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 154.0, 172.0, 133.0, 157.0, 152.0, 133.0, 175.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [162.0, 159.0, 162.0, 161.0, 160.0, 161.0, 162.0, 161.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 102.0, 95.0, 73.0, 73.0, 75.0, 113.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.9}, {"lowerIsBetter": true, "replicates": [99.0, 98.0, 142.0, 98.0, 98.0, 98.0, 144.0, 97.0, 99.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 111.6}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 115.0, 116.0, 115.0, 115.0, 115.0, 114.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 149.0, 147.0, 149.0, 150.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 76.0, 67.0, 65.0, 66.0, 67.0, 77.0, 64.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 71.0, 71.0, 71.0, 71.0, 72.0, 76.0, 72.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.7}, {"lowerIsBetter": true, "replicates": [89.0, 91.0, 89.0, 86.0, 94.0, 85.0, 87.0, 86.0, 86.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [123.0, 134.0, 128.0, 119.0, 127.0, 124.0, 121.0, 121.0, 122.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [154.0, 146.0, 153.0, 153.0, 162.0, 140.0, 151.0, 149.0, 151.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.1}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 72.0, 73.0, 75.0, 73.0, 71.0, 71.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.4}], "name": "kraken", "value": 1556.6}]} 09:35:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1556.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6037.02"}}} 09:35:18 INFO - Return code: 0 09:35:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:35:18 INFO - # TBPL SUCCESS # 09:35:18 INFO - Running post-action listener: _resource_record_post_action 09:35:18 INFO - Running post-run listener: _resource_record_post_run 09:35:19 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 2707456; Write bytes: 359989248; Read time: 1964; Write time: 245852 09:35:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 72335360; Read time: 160; Write time: 43856 09:35:19 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 2703360; Write bytes: 287653888; Read time: 1804; Write time: 201996 09:35:19 INFO - Running post-run listener: _upload_blobber_files 09:35:19 INFO - Blob upload gear active. 09:35:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:35:19 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 09:35:19 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'] 09:35:19 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 09:35:20 INFO - (blobuploader) - INFO - Open directory for files ... 09:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:20 INFO - (blobuploader) - INFO - Done attempting. 09:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:21 INFO - (blobuploader) - INFO - Done attempting. 09:35:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:35:21 INFO - Return code: 0 09:35:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:35:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:35:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b3c116ceb739b95a830adb4c77889ba3d6a66ca5c250c500635f666c19c940140db232887dcb9ad0fb73000914b28484a30ce8f53d278e3effb9dca5abac0117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36c2665d14022cd61660fce799a490a5476d362a20ab9fed9e60bc7e093993587cb42290dcd24fa062a9e632d33494746cb6a8068329ad791221031efd32575f"} 09:35:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:35:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:35:21 INFO - Contents: 09:35:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b3c116ceb739b95a830adb4c77889ba3d6a66ca5c250c500635f666c19c940140db232887dcb9ad0fb73000914b28484a30ce8f53d278e3effb9dca5abac0117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36c2665d14022cd61660fce799a490a5476d362a20ab9fed9e60bc7e093993587cb42290dcd24fa062a9e632d33494746cb6a8068329ad791221031efd32575f"} 09:35:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:35:21 INFO - Copying logs to upload dir... 09:35:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:35:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.828761 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-02-26 09:35:21.615943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 09:35:21.619021) ========= 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=4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141 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/b3c116ceb739b95a830adb4c77889ba3d6a66ca5c250c500635f666c19c940140db232887dcb9ad0fb73000914b28484a30ce8f53d278e3effb9dca5abac0117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36c2665d14022cd61660fce799a490a5476d362a20ab9fed9e60bc7e093993587cb42290dcd24fa062a9e632d33494746cb6a8068329ad791221031efd32575f"} build_url:https://queue.taskcluster.net/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/S3T_CkagSUOX12IVvmqznQ/artifacts/public/build/firefox-47.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/b3c116ceb739b95a830adb4c77889ba3d6a66ca5c250c500635f666c19c940140db232887dcb9ad0fb73000914b28484a30ce8f53d278e3effb9dca5abac0117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36c2665d14022cd61660fce799a490a5476d362a20ab9fed9e60bc7e093993587cb42290dcd24fa062a9e632d33494746cb6a8068329ad791221031efd32575f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 09:35:21.643487) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:35:21.643817) ========= 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=4dd8011cc2821079d74a932a000001ae-1456506597.423372-1979877141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004828 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 09:35:21.731612) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 09:35:21.732395) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 09:35:21.732907) ========= ========= Total master_lag: 0.24 =========