builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1457368531.69 results: success (0) buildid: 20160307052511 builduid: 1c09cc9716ee462db1d338f227fef0f2 revision: 5a8c334ac296c94faf804e12a05c3e5c6f555155 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.690936) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.691862) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.692443) ========= 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=aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004457 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.713529) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.713823) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.727804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.728300) ========= 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=aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004716 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.780134) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.780665) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.781342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.781932) ========= 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=aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-07 08:35:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-03-07 08:35:32 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095742 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.892854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.893478) ========= 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=aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022924 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:31.945050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 08:35:31.945657) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a8c334ac296c94faf804e12a05c3e5c6f555155 --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 5a8c334ac296c94faf804e12a05c3e5c6f555155 --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=aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-07 08:35:32,348 truncating revision to first 12 chars 2016-03-07 08:35:32,348 Setting DEBUG logging. 2016-03-07 08:35:32,348 attempt 1/10 2016-03-07 08:35:32,348 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a8c334ac296?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 08:35:33,155 unpacking tar archive at: fx-team-5a8c334ac296/testing/mozharness/ program finished with exit code 0 elapsedTime=1.150394 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 08:35:33.109909) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:33.110342) ========= echo 5a8c334ac296c94faf804e12a05c3e5c6f555155 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5a8c334ac296c94faf804e12a05c3e5c6f555155'] 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=aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5a8c334ac296c94faf804e12a05c3e5c6f555155 program finished with exit code 0 elapsedTime=0.003820 script_repo_revision: '5a8c334ac296c94faf804e12a05c3e5c6f555155' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:33.159515) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:33.159874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 08:35:33.169720) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-07 08:35:33.170057) ========= /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=aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:35:33 INFO - MultiFileLogger online at 20160307 08:35:33 in /builds/slave/test 08:35:33 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 08:35:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:35:33 INFO - {'append_to_log': False, 08:35:33 INFO - 'base_work_dir': '/builds/slave/test', 08:35:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:35:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:35:33 INFO - 'branch': 'Fx-Team-Non-PGO', 08:35:33 INFO - 'buildbot_json_path': 'buildprops.json', 08:35:33 INFO - 'config_files': ('talos/linux_config.py',), 08:35:33 INFO - 'default_actions': ('clobber', 08:35:33 INFO - 'read-buildbot-config', 08:35:33 INFO - 'download-and-extract', 08:35:33 INFO - 'populate-webroot', 08:35:33 INFO - 'create-virtualenv', 08:35:33 INFO - 'install', 08:35:33 INFO - 'run-tests'), 08:35:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:35:33 INFO - 'download_minidump_stackwalk': True, 08:35:33 INFO - 'download_symbols': 'ondemand', 08:35:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:35:33 INFO - 'tooltool.py': '/tools/tooltool.py', 08:35:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:35:33 INFO - '/tools/misc-python/virtualenv.py')}, 08:35:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:35:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:35:33 INFO - 'installer_path': 'installer.exe', 08:35:33 INFO - 'log_level': 'info', 08:35:33 INFO - 'log_name': 'talos', 08:35:33 INFO - 'log_to_console': True, 08:35:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:35:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:35:33 INFO - 'opt_config_files': (), 08:35:33 INFO - 'pip_index': False, 08:35:33 INFO - 'sps_profile': False, 08:35:33 INFO - 'sps_profile_interval': 0, 08:35:33 INFO - 'suite': 'dromaeojs', 08:35:33 INFO - 'system_bits': '32', 08:35:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:35:33 INFO - 'title': 'talos-linux64-ix-009', 08:35:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:35:33 INFO - 'use_talos_json': True, 08:35:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:35:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:35:33 INFO - 'work_dir': 'build'} 08:35:33 INFO - ##### 08:35:33 INFO - ##### Running clobber step. 08:35:33 INFO - ##### 08:35:33 INFO - Running pre-action listener: _resource_record_pre_action 08:35:33 INFO - Running main action method: clobber 08:35:33 INFO - rmtree: /builds/slave/test/build 08:35:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:35:34 INFO - Running post-action listener: _resource_record_post_action 08:35:34 INFO - ##### 08:35:34 INFO - ##### Running read-buildbot-config step. 08:35:34 INFO - ##### 08:35:34 INFO - Running pre-action listener: _resource_record_pre_action 08:35:34 INFO - Running main action method: read_buildbot_config 08:35:34 INFO - Using buildbot properties: 08:35:34 INFO - { 08:35:34 INFO - "project": "", 08:35:34 INFO - "product": "firefox", 08:35:34 INFO - "script_repo_revision": "production", 08:35:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:35:34 INFO - "repository": "", 08:35:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:35:34 INFO - "buildid": "20160307052511", 08:35:34 INFO - "pgo_build": "False", 08:35:34 INFO - "basedir": "/builds/slave/test", 08:35:34 INFO - "buildnumber": 2608, 08:35:34 INFO - "slavename": "talos-linux64-ix-009", 08:35:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:35:34 INFO - "platform": "ubuntu64_hw", 08:35:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:35:34 INFO - "branch": "fx-team", 08:35:34 INFO - "repo_path": "integration/fx-team", 08:35:34 INFO - "revision": "5a8c334ac296c94faf804e12a05c3e5c6f555155", 08:35:34 INFO - "stage_platform": "linux64", 08:35:34 INFO - "builduid": "1c09cc9716ee462db1d338f227fef0f2", 08:35:34 INFO - "slavebuilddir": "test" 08:35:34 INFO - } 08:35:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:35:34 INFO - Running post-action listener: _resource_record_post_action 08:35:34 INFO - ##### 08:35:34 INFO - ##### Running download-and-extract step. 08:35:34 INFO - ##### 08:35:34 INFO - Running pre-action listener: _resource_record_pre_action 08:35:34 INFO - Running main action method: download_and_extract 08:35:34 INFO - mkdir: /builds/slave/test/build/tests 08:35:34 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')]} 08:35:34 INFO - https://queue.taskcluster.net/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:35:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 08:35:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 08:35:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 08:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:35:34 INFO - Downloaded 1448 bytes. 08:35:34 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 08:35:34 INFO - Using the following test package requirements: 08:35:34 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:35:34 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:35:34 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:35:34 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:34 INFO - u'jsshell-linux-x86_64.zip'], 08:35:34 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:35:34 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:35:34 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:35:34 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:35:34 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:35:34 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:35:34 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:35:34 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:35:34 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')]} 08:35:34 INFO - https://queue.taskcluster.net/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:35:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:35:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:35:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/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 08:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/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 08:35:36 INFO - Downloaded 22092060 bytes. 08:35:36 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'] 08:35:36 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 08:35:37 INFO - Return code: 0 08:35:37 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 08:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:37 INFO - https://queue.taskcluster.net/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:35:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:35:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:35:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/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 08:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/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 08:35:39 INFO - Downloaded 22092060 bytes. 08:35:39 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'] 08:35:39 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 08:35:40 INFO - Return code: 0 08:35: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')]} 08:35:40 INFO - https://queue.taskcluster.net/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:35:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:35:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:35:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/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 08:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/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 08:35:41 INFO - Downloaded 10845161 bytes. 08:35:41 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'] 08:35:41 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 08:35:41 INFO - Return code: 0 08:35: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')]} 08:35:41 INFO - https://queue.taskcluster.net/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/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 08:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0fGofpyTzarzL2-yxGYJA/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 08:35:43 INFO - Downloaded 54407196 bytes. 08:35:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:35:43 INFO - mkdir: /builds/slave/test/properties 08:35:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:35:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:35:43 INFO - Contents: 08:35:43 INFO - build_url:https://queue.taskcluster.net/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:35:43 INFO - Running post-action listener: _resource_record_post_action 08:35:43 INFO - Running post-action listener: set_extra_try_arguments 08:35:43 INFO - ##### 08:35:43 INFO - ##### Running populate-webroot step. 08:35:43 INFO - ##### 08:35:43 INFO - Running pre-action listener: _resource_record_pre_action 08:35:43 INFO - Running main action method: populate_webroot 08:35:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:35:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:35:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:35:43 INFO - '--tppagecycles', 08:35:43 INFO - '7'], 08:35:43 INFO - 'tests': ['tsvgm']}}, 08:35:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:35:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:35:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:35:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:35:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:35:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:35:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:43 INFO - 'talos_options': ['--e10s'], 08:35:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:43 INFO - 'tests': ['damp', 'tps']}, 08:35:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:43 INFO - 'talos_options': ['--e10s'], 08:35:43 INFO - 'tests': ['damp', 'tps']}, 08:35:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:35:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:35:43 INFO - 'other': {'tests': ['a11yr', 08:35:43 INFO - 'ts_paint', 08:35:43 INFO - 'tpaint', 08:35:43 INFO - 'sessionrestore', 08:35:43 INFO - 'sessionrestore_no_auto_restore', 08:35:43 INFO - 'tabpaint']}, 08:35:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:35:43 INFO - 'tests': ['a11yr', 08:35:43 INFO - 'ts_paint', 08:35:43 INFO - 'tpaint', 08:35:43 INFO - 'sessionrestore', 08:35:43 INFO - 'sessionrestore_no_auto_restore', 08:35:43 INFO - 'tabpaint']}, 08:35:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:35:43 INFO - 'tests': ['a11yr', 08:35:43 INFO - 'ts_paint', 08:35:43 INFO - 'tpaint', 08:35:43 INFO - 'sessionrestore', 08:35:43 INFO - 'sessionrestore_no_auto_restore', 08:35:43 INFO - 'tabpaint']}, 08:35:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:35:43 INFO - 'tests': ['a11yr', 08:35:43 INFO - 'ts_paint', 08:35:43 INFO - 'tpaint', 08:35:43 INFO - 'sessionrestore', 08:35:43 INFO - 'sessionrestore_no_auto_restore', 08:35:43 INFO - 'tabpaint']}, 08:35:43 INFO - 'other_l64': {'tests': ['a11yr', 08:35:43 INFO - 'ts_paint', 08:35:43 INFO - 'tpaint', 08:35:43 INFO - 'sessionrestore', 08:35:43 INFO - 'sessionrestore_no_auto_restore', 08:35:43 INFO - 'tabpaint']}, 08:35:43 INFO - 'other_nol64': {'tests': ['a11yr', 08:35:43 INFO - 'ts_paint', 08:35:43 INFO - 'tpaint', 08:35:43 INFO - 'sessionrestore', 08:35:43 INFO - 'sessionrestore_no_auto_restore', 08:35:43 INFO - 'tabpaint']}, 08:35:43 INFO - 'svgr': {'tests': ['tsvgx', 08:35:43 INFO - 'tsvgr_opacity', 08:35:43 INFO - 'tart', 08:35:43 INFO - 'tscrollx', 08:35:43 INFO - 'cart']}, 08:35:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:35:43 INFO - 'tests': ['tsvgx', 08:35:43 INFO - 'tsvgr_opacity', 08:35:43 INFO - 'tart', 08:35:43 INFO - 'tscrollx', 08:35:43 INFO - 'cart']}, 08:35:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:43 INFO - 'tests': ['tp5o']}, 08:35:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:43 INFO - 'talos_options': ['--e10s'], 08:35:43 INFO - 'tests': ['tp5o']}, 08:35:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:43 INFO - 'talos_options': ['--xperf_path', 08:35:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:43 INFO - 'tests': ['tp5n']}, 08:35:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:43 INFO - 'talos_options': ['--e10s', 08:35:43 INFO - '--xperf_path', 08:35:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:43 INFO - 'tests': ['tp5n']}}, 08:35:43 INFO - 'talos.zip': {'path': '', 08:35:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:35:43 INFO - Running post-action listener: _resource_record_post_action 08:35:43 INFO - ##### 08:35:43 INFO - ##### Running create-virtualenv step. 08:35:43 INFO - ##### 08:35:43 INFO - Running pre-action listener: _resource_record_pre_action 08:35:43 INFO - Running main action method: create_virtualenv 08:35:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:35:43 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 08:35:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:35:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:35:43 INFO - Using real prefix '/usr' 08:35:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:35:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:35:46 INFO - Installing pip.................done. 08:35:46 INFO - Return code: 0 08:35:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:35:46 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')]} 08:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:46 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')]} 08:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:46 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 0x7ff583c43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae160>, '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 0x1faf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1faf4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', '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 08:35:46 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 08:35:46 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 08:35:46 INFO - Using env: {'DISPLAY': ':0', 08:35:46 INFO - 'HOME': '/home/cltbld', 08:35:46 INFO - 'LANG': 'en_US.UTF-8', 08:35:46 INFO - 'LANGUAGE': 'en_US:en', 08:35:46 INFO - 'LOGNAME': 'cltbld', 08:35:46 INFO - 'MAIL': '/var/mail/cltbld', 08:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:46 INFO - 'MOZ_NO_REMOTE': '1', 08:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:46 INFO - 'NO_EM_RESTART': '1', 08:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:46 INFO - 'PWD': '/builds/slave/test', 08:35:46 INFO - 'SHELL': '/bin/bash', 08:35:46 INFO - 'SHLVL': '1', 08:35:46 INFO - 'TERM': 'linux', 08:35:46 INFO - 'TMOUT': '86400', 08:35:46 INFO - 'USER': 'cltbld', 08:35:46 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', 08:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:46 INFO - '_': '/tools/buildbot/bin/python'} 08:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:46 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 08:35:46 INFO - Cleaning up... 08:35:46 INFO - Return code: 0 08:35:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:35:46 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')]} 08:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:46 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')]} 08:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:46 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 0x7ff583c43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae160>, '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 0x1faf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1faf4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', '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 08:35:46 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 08:35:46 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 08:35:46 INFO - Using env: {'DISPLAY': ':0', 08:35:46 INFO - 'HOME': '/home/cltbld', 08:35:46 INFO - 'LANG': 'en_US.UTF-8', 08:35:46 INFO - 'LANGUAGE': 'en_US:en', 08:35:46 INFO - 'LOGNAME': 'cltbld', 08:35:46 INFO - 'MAIL': '/var/mail/cltbld', 08:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:46 INFO - 'MOZ_NO_REMOTE': '1', 08:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:46 INFO - 'NO_EM_RESTART': '1', 08:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:46 INFO - 'PWD': '/builds/slave/test', 08:35:46 INFO - 'SHELL': '/bin/bash', 08:35:46 INFO - 'SHLVL': '1', 08:35:46 INFO - 'TERM': 'linux', 08:35:46 INFO - 'TMOUT': '86400', 08:35:46 INFO - 'USER': 'cltbld', 08:35:46 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', 08:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:46 INFO - '_': '/tools/buildbot/bin/python'} 08:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:46 INFO - Downloading/unpacking psutil>=0.7.1 08:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:35:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:48 INFO - Installing collected packages: psutil 08:35:48 INFO - Running setup.py install for psutil 08:35:48 INFO - building 'psutil._psutil_linux' extension 08:35:48 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 08:35:48 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 08:35:48 INFO - building 'psutil._psutil_posix' extension 08:35:48 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 08:35:49 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 08:35:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:49 INFO - Successfully installed psutil 08:35:49 INFO - Cleaning up... 08:35:49 INFO - Return code: 0 08:35:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:49 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 0x7ff583c43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae160>, '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 0x1faf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1faf4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', '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 08:35:49 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 08:35:49 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 08:35:49 INFO - Using env: {'DISPLAY': ':0', 08:35:49 INFO - 'HOME': '/home/cltbld', 08:35:49 INFO - 'LANG': 'en_US.UTF-8', 08:35:49 INFO - 'LANGUAGE': 'en_US:en', 08:35:49 INFO - 'LOGNAME': 'cltbld', 08:35:49 INFO - 'MAIL': '/var/mail/cltbld', 08:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:49 INFO - 'MOZ_NO_REMOTE': '1', 08:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:49 INFO - 'NO_EM_RESTART': '1', 08:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:49 INFO - 'PWD': '/builds/slave/test', 08:35:49 INFO - 'SHELL': '/bin/bash', 08:35:49 INFO - 'SHLVL': '1', 08:35:49 INFO - 'TERM': 'linux', 08:35:49 INFO - 'TMOUT': '86400', 08:35:49 INFO - 'USER': 'cltbld', 08:35:49 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', 08:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:49 INFO - '_': '/tools/buildbot/bin/python'} 08:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:35:51 INFO - Installing collected packages: mozsystemmonitor 08:35:51 INFO - Running setup.py install for mozsystemmonitor 08:35:51 INFO - Successfully installed mozsystemmonitor 08:35:51 INFO - Cleaning up... 08:35:51 INFO - Return code: 0 08:35:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:51 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 0x7ff583c43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae160>, '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 0x1faf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1faf4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', '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 08:35:51 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 08:35:51 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 08:35:51 INFO - Using env: {'DISPLAY': ':0', 08:35:51 INFO - 'HOME': '/home/cltbld', 08:35:51 INFO - 'LANG': 'en_US.UTF-8', 08:35:51 INFO - 'LANGUAGE': 'en_US:en', 08:35:51 INFO - 'LOGNAME': 'cltbld', 08:35:51 INFO - 'MAIL': '/var/mail/cltbld', 08:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:51 INFO - 'MOZ_NO_REMOTE': '1', 08:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:51 INFO - 'NO_EM_RESTART': '1', 08:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:51 INFO - 'PWD': '/builds/slave/test', 08:35:51 INFO - 'SHELL': '/bin/bash', 08:35:51 INFO - 'SHLVL': '1', 08:35:51 INFO - 'TERM': 'linux', 08:35:51 INFO - 'TMOUT': '86400', 08:35:51 INFO - 'USER': 'cltbld', 08:35:51 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', 08:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:51 INFO - '_': '/tools/buildbot/bin/python'} 08:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:35:51 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 08:35:51 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 08:35:51 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 08:35:51 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 08:35:51 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 08:35:51 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 08:35:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:35:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:35:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:54 INFO - Downloading docopt-0.6.1.tar.gz 08:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:35:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:35:54 INFO - Running setup.py install for blobuploader 08:35:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:35:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:35:54 INFO - Running setup.py install for requests 08:35:54 INFO - Running setup.py install for docopt 08:35:54 INFO - Successfully installed blobuploader requests docopt 08:35:54 INFO - Cleaning up... 08:35:54 INFO - Return code: 0 08:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:54 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 0x7ff583c43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae160>, '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 0x1faf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1faf4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', '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 08:35:54 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 08:35:54 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 08:35:54 INFO - Using env: {'DISPLAY': ':0', 08:35:54 INFO - 'HOME': '/home/cltbld', 08:35:54 INFO - 'LANG': 'en_US.UTF-8', 08:35:54 INFO - 'LANGUAGE': 'en_US:en', 08:35:54 INFO - 'LOGNAME': 'cltbld', 08:35:54 INFO - 'MAIL': '/var/mail/cltbld', 08:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:54 INFO - 'MOZ_NO_REMOTE': '1', 08:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:54 INFO - 'NO_EM_RESTART': '1', 08:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:54 INFO - 'PWD': '/builds/slave/test', 08:35:54 INFO - 'SHELL': '/bin/bash', 08:35:54 INFO - 'SHLVL': '1', 08:35:54 INFO - 'TERM': 'linux', 08:35:54 INFO - 'TMOUT': '86400', 08:35:54 INFO - 'USER': 'cltbld', 08:35:54 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', 08:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:54 INFO - '_': '/tools/buildbot/bin/python'} 08:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:55 INFO - Running setup.py (path:/tmp/pip-pu9mBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:55 INFO - Running setup.py (path:/tmp/pip-vinuep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:55 INFO - Running setup.py (path:/tmp/pip-f9w2_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:55 INFO - Running setup.py (path:/tmp/pip-8Oc3Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:55 INFO - Running setup.py (path:/tmp/pip-5x1qDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:55 INFO - Running setup.py (path:/tmp/pip-kOjlYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:55 INFO - Running setup.py (path:/tmp/pip-XBVnoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:55 INFO - Running setup.py (path:/tmp/pip-nF3a6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:55 INFO - Running setup.py (path:/tmp/pip-gMABuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:55 INFO - Running setup.py (path:/tmp/pip-iQMEDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:55 INFO - Running setup.py (path:/tmp/pip-0skPkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:55 INFO - Running setup.py (path:/tmp/pip-6Kz1Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:55 INFO - Running setup.py (path:/tmp/pip-hSo6ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:55 INFO - Running setup.py (path:/tmp/pip-XbsbYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:56 INFO - Running setup.py (path:/tmp/pip-hbOXiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:56 INFO - Running setup.py (path:/tmp/pip-hmRWFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:56 INFO - Running setup.py (path:/tmp/pip-h9lXAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:35:56 INFO - Running setup.py install for manifestparser 08:35:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:35:56 INFO - Running setup.py install for mozcrash 08:35:56 INFO - Running setup.py install for mozdebug 08:35:56 INFO - Running setup.py install for mozdevice 08:35:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:35:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:35:56 INFO - Running setup.py install for mozfile 08:35:56 INFO - Running setup.py install for mozhttpd 08:35:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:35:56 INFO - Running setup.py install for mozinfo 08:35:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:35:56 INFO - Running setup.py install for mozInstall 08:35:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:35:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:35:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:35:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:35:57 INFO - Running setup.py install for mozleak 08:35:57 INFO - Running setup.py install for mozlog 08:35:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:35:57 INFO - Running setup.py install for moznetwork 08:35:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:35:57 INFO - Running setup.py install for mozprocess 08:35:57 INFO - Running setup.py install for mozprofile 08:35:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:35:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:35:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:35:57 INFO - Running setup.py install for mozrunner 08:35:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:35:57 INFO - Running setup.py install for mozscreenshot 08:35:57 INFO - Running setup.py install for moztest 08:35:57 INFO - Running setup.py install for mozversion 08:35:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:35:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:35:58 INFO - Cleaning up... 08:35:58 INFO - Return code: 0 08:35:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:58 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 0x7ff583c43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae160>, '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 0x1faf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1faf4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', '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 08:35:58 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 08:35:58 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 08:35:58 INFO - Using env: {'DISPLAY': ':0', 08:35:58 INFO - 'HOME': '/home/cltbld', 08:35:58 INFO - 'LANG': 'en_US.UTF-8', 08:35:58 INFO - 'LANGUAGE': 'en_US:en', 08:35:58 INFO - 'LOGNAME': 'cltbld', 08:35:58 INFO - 'MAIL': '/var/mail/cltbld', 08:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:58 INFO - 'MOZ_NO_REMOTE': '1', 08:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:58 INFO - 'NO_EM_RESTART': '1', 08:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:58 INFO - 'PWD': '/builds/slave/test', 08:35:58 INFO - 'SHELL': '/bin/bash', 08:35:58 INFO - 'SHLVL': '1', 08:35:58 INFO - 'TERM': 'linux', 08:35:58 INFO - 'TMOUT': '86400', 08:35:58 INFO - 'USER': 'cltbld', 08:35:58 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', 08:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:58 INFO - '_': '/tools/buildbot/bin/python'} 08:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:58 INFO - Running setup.py (path:/tmp/pip-4qCQR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:58 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)) 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:58 INFO - Running setup.py (path:/tmp/pip-pUd0C4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:58 INFO - Running setup.py (path:/tmp/pip-IfIxv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:58 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)) 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:58 INFO - Running setup.py (path:/tmp/pip-9zMkvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:58 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)) 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:58 INFO - Running setup.py (path:/tmp/pip-IxgkTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:58 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)) 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:58 INFO - Running setup.py (path:/tmp/pip-5NO4uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:58 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)) 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:58 INFO - Running setup.py (path:/tmp/pip-DKaacf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:58 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)) 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:58 INFO - Running setup.py (path:/tmp/pip-MQET_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:58 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)) 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:58 INFO - Running setup.py (path:/tmp/pip-gPmtPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:58 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)) 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:58 INFO - Running setup.py (path:/tmp/pip-Yf9Jhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:58 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)) 08:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:58 INFO - Running setup.py (path:/tmp/pip-My6kNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:59 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)) 08:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:59 INFO - Running setup.py (path:/tmp/pip-dvNSzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:59 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)) 08:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:59 INFO - Running setup.py (path:/tmp/pip-oW1jAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:59 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)) 08:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:59 INFO - Running setup.py (path:/tmp/pip-lv8y9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:59 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)) 08:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:59 INFO - Running setup.py (path:/tmp/pip-nyqFvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:59 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)) 08:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:59 INFO - Running setup.py (path:/tmp/pip-59or4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:59 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)) 08:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:59 INFO - Running setup.py (path:/tmp/pip-eVoo77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:59 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)) 08:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:59 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)) 08:35:59 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)) 08:35:59 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)) 08:35:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:59 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 08:35:59 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 08:35:59 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 08:35:59 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 08:35:59 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 08:35:59 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 08:36:01 INFO - Downloading blessings-1.6.tar.gz 08:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:01 INFO - Installing collected packages: blessings 08:36:01 INFO - Running setup.py install for blessings 08:36:01 INFO - Successfully installed blessings 08:36:01 INFO - Cleaning up... 08:36:01 INFO - Return code: 0 08:36:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:01 INFO - Reading from file tmpfile_stdout 08:36:01 INFO - Current package versions: 08:36:01 INFO - argparse == 1.2.1 08:36:01 INFO - blessings == 1.6 08:36:01 INFO - blobuploader == 1.2.4 08:36:01 INFO - docopt == 0.6.1 08:36:01 INFO - manifestparser == 1.1 08:36:01 INFO - mozInstall == 1.12 08:36:01 INFO - mozcrash == 0.17 08:36:01 INFO - mozdebug == 0.1 08:36:01 INFO - mozdevice == 0.48 08:36:01 INFO - mozfile == 1.2 08:36:01 INFO - mozhttpd == 0.7 08:36:01 INFO - mozinfo == 0.9 08:36:01 INFO - mozleak == 0.1 08:36:01 INFO - mozlog == 3.1 08:36:01 INFO - moznetwork == 0.27 08:36:01 INFO - mozprocess == 0.22 08:36:01 INFO - mozprofile == 0.28 08:36:01 INFO - mozrunner == 6.11 08:36:01 INFO - mozscreenshot == 0.1 08:36:01 INFO - mozsystemmonitor == 0.0 08:36:01 INFO - moztest == 0.7 08:36:01 INFO - mozversion == 1.4 08:36:01 INFO - psutil == 3.1.1 08:36:01 INFO - requests == 1.2.3 08:36:01 INFO - wsgiref == 0.1.2 08:36:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36: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')]} 08:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:01 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 0x7ff583c43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae160>, '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 0x1faf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1faf4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', '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 08:36:01 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 08:36:01 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 08:36:01 INFO - Using env: {'DISPLAY': ':0', 08:36:01 INFO - 'HOME': '/home/cltbld', 08:36:01 INFO - 'LANG': 'en_US.UTF-8', 08:36:01 INFO - 'LANGUAGE': 'en_US:en', 08:36:01 INFO - 'LOGNAME': 'cltbld', 08:36:01 INFO - 'MAIL': '/var/mail/cltbld', 08:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:01 INFO - 'MOZ_NO_REMOTE': '1', 08:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:01 INFO - 'NO_EM_RESTART': '1', 08:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:01 INFO - 'PWD': '/builds/slave/test', 08:36:01 INFO - 'SHELL': '/bin/bash', 08:36:01 INFO - 'SHLVL': '1', 08:36:01 INFO - 'TERM': 'linux', 08:36:01 INFO - 'TMOUT': '86400', 08:36:01 INFO - 'USER': 'cltbld', 08:36:01 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', 08:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:01 INFO - '_': '/tools/buildbot/bin/python'} 08:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:01 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)) 08:36:01 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)) 08:36:01 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)) 08:36:01 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)) 08:36:01 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)) 08:36:01 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)) 08:36:01 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)) 08:36:01 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)) 08:36:01 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)) 08:36:01 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)) 08:36:01 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)) 08:36:01 INFO - Cleaning up... 08:36:01 INFO - Return code: 0 08:36:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36: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')]} 08:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff583c43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae160>, '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 0x1faf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1faf4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', '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 08:36: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', 'jsonschema'] in /builds/slave/test/build 08:36: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 jsonschema 08:36:01 INFO - Using env: {'DISPLAY': ':0', 08:36:01 INFO - 'HOME': '/home/cltbld', 08:36:01 INFO - 'LANG': 'en_US.UTF-8', 08:36:01 INFO - 'LANGUAGE': 'en_US:en', 08:36:01 INFO - 'LOGNAME': 'cltbld', 08:36:01 INFO - 'MAIL': '/var/mail/cltbld', 08:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:01 INFO - 'MOZ_NO_REMOTE': '1', 08:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:01 INFO - 'NO_EM_RESTART': '1', 08:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:01 INFO - 'PWD': '/builds/slave/test', 08:36:01 INFO - 'SHELL': '/bin/bash', 08:36:01 INFO - 'SHLVL': '1', 08:36:01 INFO - 'TERM': 'linux', 08:36:01 INFO - 'TMOUT': '86400', 08:36:01 INFO - 'USER': 'cltbld', 08:36:01 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', 08:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:01 INFO - '_': '/tools/buildbot/bin/python'} 08:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:02 INFO - Downloading/unpacking jsonschema 08:36:02 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 08:36:02 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 08:36:02 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 08:36:02 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 08:36:02 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 08:36:02 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 08:36:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:04 INFO - Downloading/unpacking functools32 (from jsonschema) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:04 INFO - warning: no files found matching '*.txt' 08:36:04 INFO - no previously-included directories found matching 'build' 08:36:04 INFO - no previously-included directories found matching 'dist' 08:36:04 INFO - no previously-included directories found matching '.git*' 08:36:04 INFO - Installing collected packages: jsonschema, functools32 08:36:04 INFO - Running setup.py install for functools32 08:36:04 INFO - warning: no files found matching '*.txt' 08:36:04 INFO - no previously-included directories found matching 'build' 08:36:04 INFO - no previously-included directories found matching 'dist' 08:36:04 INFO - no previously-included directories found matching '.git*' 08:36:04 INFO - Successfully installed jsonschema functools32 08:36:04 INFO - Cleaning up... 08:36:04 INFO - Return code: 0 08:36:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:36: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')]} 08:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff583c43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1f410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae160>, '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 0x1faf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1faf4f0>, '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': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', '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 08:36: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', 'flake8'] in /builds/slave/test/build 08:36: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 flake8 08:36:04 INFO - Using env: {'DISPLAY': ':0', 08:36:04 INFO - 'HOME': '/home/cltbld', 08:36:04 INFO - 'LANG': 'en_US.UTF-8', 08:36:04 INFO - 'LANGUAGE': 'en_US:en', 08:36:04 INFO - 'LOGNAME': 'cltbld', 08:36:04 INFO - 'MAIL': '/var/mail/cltbld', 08:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:04 INFO - 'MOZ_NO_REMOTE': '1', 08:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:04 INFO - 'NO_EM_RESTART': '1', 08:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:04 INFO - 'PWD': '/builds/slave/test', 08:36:04 INFO - 'SHELL': '/bin/bash', 08:36:04 INFO - 'SHLVL': '1', 08:36:04 INFO - 'TERM': 'linux', 08:36:04 INFO - 'TMOUT': '86400', 08:36:04 INFO - 'USER': 'cltbld', 08:36:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', 08:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:04 INFO - '_': '/tools/buildbot/bin/python'} 08:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:04 INFO - Downloading/unpacking flake8 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:36:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:36:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:36:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:07 INFO - no previously-included directories found matching 'docs/_build' 08:36:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:36:07 INFO - Running setup.py install for pep8 08:36:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:07 INFO - no previously-included directories found matching 'docs/_build' 08:36:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:36:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:36:07 INFO - Cleaning up... 08:36:07 INFO - Return code: 0 08:36:07 INFO - Running post-action listener: _resource_record_post_action 08:36:07 INFO - Running post-action listener: _start_resource_monitoring 08:36:07 INFO - Starting resource monitoring. 08:36:07 INFO - ##### 08:36:07 INFO - ##### Running install step. 08:36:07 INFO - ##### 08:36:07 INFO - Running pre-action listener: _resource_record_pre_action 08:36:07 INFO - Running main action method: install 08:36:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:07 INFO - Reading from file tmpfile_stdout 08:36:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:36:07 INFO - Reading from file tmpfile_stdout 08:36:07 INFO - Output received: 08:36:07 INFO - Usage: mozinstall [options] installer 08:36:07 INFO - Options: 08:36:07 INFO - -h, --help show this help message and exit 08:36:07 INFO - -d DEST, --destination=DEST 08:36:07 INFO - Directory to install application into. [default: 08:36:07 INFO - "/builds/slave/test"] 08:36:07 INFO - --app=APP Application being installed. [default: firefox] 08:36:07 INFO - mkdir: /builds/slave/test/build/application 08:36:07 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'] 08:36:07 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 08:36:23 INFO - Reading from file tmpfile_stdout 08:36:23 INFO - Output received: 08:36:23 INFO - /builds/slave/test/build/application/firefox/firefox 08:36:23 INFO - Running post-action listener: _resource_record_post_action 08:36:23 INFO - ##### 08:36:23 INFO - ##### Running run-tests step. 08:36:23 INFO - ##### 08:36:23 INFO - Running pre-action listener: _resource_record_pre_action 08:36:23 INFO - Running main action method: run_tests 08:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:36:23 INFO - Python 2.7.3 08:36:23 INFO - Return code: 0 08:36:23 INFO - grabbing minidump binary from tooltool 08:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:23 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 0x1fae160>, '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 0x1faf060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1faf4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:36:23 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 08:36:23 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 08:36:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:36:23 INFO - Return code: 0 08:36:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:36:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:36:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:36:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:36:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:36:24 INFO - Return code: 0 08:36:24 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/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 08:36:24 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/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 08:36:24 INFO - Using env: {'DISPLAY': ':0', 08:36:24 INFO - 'HOME': '/home/cltbld', 08:36:24 INFO - 'LANG': 'en_US.UTF-8', 08:36:24 INFO - 'LANGUAGE': 'en_US:en', 08:36:24 INFO - 'LOGNAME': 'cltbld', 08:36:24 INFO - 'MAIL': '/var/mail/cltbld', 08:36:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:36:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:24 INFO - 'MOZ_NO_REMOTE': '1', 08:36:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:24 INFO - 'NO_EM_RESTART': '1', 08:36:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:24 INFO - 'PWD': '/builds/slave/test', 08:36:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:36:24 INFO - 'SHELL': '/bin/bash', 08:36:24 INFO - 'SHLVL': '1', 08:36:24 INFO - 'TERM': 'linux', 08:36:24 INFO - 'TMOUT': '86400', 08:36:24 INFO - 'USER': 'cltbld', 08:36:24 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095', 08:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:24 INFO - '_': '/tools/buildbot/bin/python'} 08:36:24 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/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 08:36:24 INFO - mozversion application_buildid: 20160307052511 08:36:24 INFO - mozversion application_changeset: 5a8c334ac296c94faf804e12a05c3e5c6f555155 08:36:24 INFO - mozversion application_display_name: Nightly 08:36:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:36:24 INFO - mozversion application_name: Firefox 08:36:24 INFO - mozversion application_remotingname: firefox 08:36:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:36:24 INFO - mozversion application_vendor: Mozilla 08:36:24 INFO - mozversion application_version: 47.0a1 08:36:24 INFO - mozversion platform_buildid: 20160307052511 08:36:24 INFO - mozversion platform_changeset: 5a8c334ac296c94faf804e12a05c3e5c6f555155 08:36:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:36:24 INFO - mozversion platform_version: 47.0a1 08:36:24 INFO - using testdate: 1457368584 08:36:24 INFO - actual date: 1457368584 08:36:24 INFO - starting webserver on 'localhost:39502' 08:36:24 INFO - SUITE-START | Running 2 tests 08:36:24 INFO - TEST-START | dromaeo_css 08:36:24 INFO - operating with platform_type : linux_ 08:36:24 INFO - Initialising browser for dromaeo_css test... 08:36:24 INFO - TEST-INFO | started process 17190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7KfteC/profile http://localhost:39502/getInfo.html) 08:36:29 INFO - PROCESS | 17190 | __metrics Screen width/height:1600/1200 08:36:29 INFO - PROCESS | 17190 | colorDepth:24 08:36:29 INFO - PROCESS | 17190 | Browser inner width/height: 1024/697 08:36:29 INFO - PROCESS | 17190 | __metrics 08:36:30 INFO - PROCESS | 17190 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:36:31 INFO - TEST-INFO | 17190: exit 0 08:36:31 INFO - Browser initialized. 08:36:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:36:31 INFO - TEST-INFO | started process 17285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7KfteC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:43 INFO - PROCESS | 17285 | RSS: Main: 156106752 08:36:43 INFO - PROCESS | 17285 | 08:37:34 INFO - PROCESS | 17285 | 1457368654827 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] 08:39:46 INFO - PROCESS | 17285 | Cycle 1(1): loaded http://localhost:39502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39502/tests/dromaeo/cssquery-ext.html) 08:39:47 INFO - PROCESS | 17285 | RSS: Main: 240857088 08:39:47 INFO - PROCESS | 17285 | 08:42:49 INFO - PROCESS | 17285 | Cycle 1(1): loaded http://localhost:39502/tests/dromaeo/cssquery-ext.html (next: http://localhost:39502/tests/dromaeo/cssquery-jquery.html) 08:42:50 INFO - PROCESS | 17285 | RSS: Main: 237293568 08:42:50 INFO - PROCESS | 17285 | 08:45:52 INFO - PROCESS | 17285 | Cycle 1(1): loaded http://localhost:39502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39502/tests/dromaeo/cssquery-mootools.html) 08:45:53 INFO - PROCESS | 17285 | RSS: Main: 233947136 08:45:53 INFO - PROCESS | 17285 | 08:48:54 INFO - PROCESS | 17285 | Cycle 1(1): loaded http://localhost:39502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39502/tests/dromaeo/cssquery-prototype.html) 08:48:55 INFO - PROCESS | 17285 | RSS: Main: 216059904 08:48:55 INFO - PROCESS | 17285 | 08:51:58 INFO - PROCESS | 17285 | Cycle 1(1): loaded http://localhost:39502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39502/tests/dromaeo/cssquery-yui.html) 08:51:58 INFO - PROCESS | 17285 | RSS: Main: 199061504 08:51:58 INFO - PROCESS | 17285 | 08:55:01 INFO - PROCESS | 17285 | Cycle 1(1): loaded http://localhost:39502/tests/dromaeo/cssquery-yui.html (next: http://localhost:39502/tests/dromaeo/cssquery-dojo.html) 08:55:01 INFO - PROCESS | 17285 | RSS: Main: 302936064 08:55:01 INFO - PROCESS | 17285 | 08:55:01 INFO - PROCESS | 17285 | __start_tp_report 08:55:01 INFO - PROCESS | 17285 | _x_x_mozilla_page_load 08:55:01 INFO - PROCESS | 17285 | _x_x_mozilla_page_load_details 08:55:01 INFO - PROCESS | 17285 | |i|pagename|runs| 08:55:01 INFO - PROCESS | 17285 | |0;dojo.html;2560.3727086863714;2632.1313966391094;2634.1439032314493;2656.4687062587486;2672.2384120525653;4411.977940110303;4512.1426928883575;4526.932096018558;4529.116822219665;4543.386642803221;4520.434945631796;4525.751083690396;4560.2475591527445;4576.13053519831;4619.353290539327;4169.270377683908;4174.31123864562;4178.749275043492;4179.33130699089;4324.827006919735;4071.42999980003;4239.703220774547;4287.164003019397;4300.311950087987;4307.892302692427;4141.7514949103;4144.544100148981;4223.809928553223;4239.830406783725;4265.466816647919;4168.166366726667;4196.727212731163;4197.244495990721;4198.475190601175;4238.067625122499;4175.519815221258;4185.707000509966;4189.6438802701805;4205.158968206371;4214.852480163179;4338.566143385668;4438.045820148684;4511.6165125964335;4556.225441674923;4568.680192386534;4854.417469903598;4855.951440485585;4866.489018653026;4867.756612169377;4908.656394052417;4708.552687494683;4875.098106850209;4885.389326334208;4885.389326334208;4943.283223932545;4465.263231566788;4508.985478267429;4517.480489743722;4545.749983750892;4551.977240113778;4918.1884988977135;4929.901401971941;4939.753012349368;4942.827001055018;4983.950160498349;4621.2837010263465;4729.5034021427255;4742.596879265301;4749.525047495223;4749.833755818529;4860;4877.804887804519;4885.560299573055;4886.193778026657;4919.532644398776;4834.589059929875;4834.734089625034;4836.516348365206;4838.7338696372035;4844.95155048445;4682.2508398656055;4778.474367819537;4798.424189097331;4825.782839772219;4873.244647079709;4063.065494936181;4067.4508941292547;4085.85699500522;4087.1008378156757;4100.569440208795;3553.6979356754964;3570.4465807799834;3576.3741345264475;3598.8560457581925;3614.1145419372424;4080.326746086922;4158.106007208404;4184.560621134798;4188.32986722123;4237.5762423758;4865.732384718804;4873.463918968911;4874.634402419832;4893.559579637849;4899.58353539946;4170.874873753793;4180.749155050707;4182.1008483176265;4183.477065366829;4223.598758117974;4190.28765109932;4297.376880352332;4320.632746216544;4397.912041759147;4401.493828209733;4610.654200934876;4616.28447590624;4625.352450656911;4627.768611569475;4663.930041049455;4863.392075990501;4871.3667223260745;4872.561469467765;4878;4917.114919314415;4502.662300327423;4614.192516309699;4647.233206520887;4666.789994450326;4693.22561777303;4809.134355815987;4813.03739252158;4827.903441931212;4830.106430310404;4876.024795040935;4694.155052090657;4890.828820991248;4892.633052521146;4894.608431325414;4942.481039490802;4682.648801339845;4764.213904705824;4764.904701906012;4794.976025119991;4806.903861922812;4682.531746825291;4705.882352941204;4706.0823139487475;4706.717596944194;4747.83382581608;4545.363649089064;4607.032523170172;4607.14767767964;4610.79251433693;4651.906961860676;4773.594244489118;4782.976085119552;4790.209615413418;4793.424789025339;4834.371531700856;4648.674592778473;4659.534046595313;4664.650151238603;4665.650076244363;4707.270373092176 08:55:01 INFO - PROCESS | 17285 | |1;ext.html;492.1731491094959;492.20017471608656;512.8922926185501;525.618926278448;539.2665974274987;24000.63999040016;31901.680983190192;32319.838400807963;32414.18964525888;32415.51376729345;35758.2848343033;36237;36262.27475450489;36263;36281.2743745125;6726.192856857184;7664.616769161547;7850.254225848564;7850.3327217186325;9518.428894266366;9720.562574684122;9873.506324683736;9887.90112098877;9893.109620134186;9900.306978511508;9824.557894894711;9946.65186718465;9947.701568952907;9949.253805964545;9957.950210248939;9747.463889486075;9851.458169800659;9854.359466634645;9856.901430985741;9861.211103111806;9641.758956026086;10040.544121102472;10045;10054.9497252514;10056.195504359634;37263.441048384295;37803;37885.24229515422;37893.43159852605;37918.81040594779;2869.9426011479864;2921.6201893753678;2949.130006648044;2950.262434391402;3109.70457806508;28439.573406398922;28584.28539286514;28818.279543011384;29117.41765164706;29909;3474.1662001119803;3508.4912687660403;3510.9297814043575;3624.4563315502887;3693.279810436966;222655;222755;222868.88565557232;223561;223595;51592;52432.21351679728;52437;52442.73778631083;52522.73738631282;44360.77819610946;45426;45522.317165242544;46133.538664613596;46275.768621156676;12909.419076141596;13117.278549679859;13124.212547247005;13129.277889716157;13207.933960330136;8942.642294308285;9653;9751;9770.560324785401;9801.31390802637;18063.909680451514;18085.457436276934;18234.36179733703;18252.996085215174;18255.08724563793;7352.63236838156;7524.473286869867;7546.660400282;7637.923620763832;7688.423368247404;818.5784321074651;822.6750433578703;880.4321212817697;944.4003058058045;997.8004399120205;25569.37264216824;26771.19686409411;26855.060072897744;26858;26908.461830763274;915.8809354783835;931.7856892914667;950.7813202963357;961.624966263158;1006.8389057750725;13536.187828730308;14176.149431033964;14921.70156596862;15680.607984800243;15886.364545418053;233569;236723;236775;236928;237864;42751.35872961908;42927.57072429298;43125;43173;43173.35239971403;1097.742030622819;1159.7332613498943;1190.7856585814463;1201.7656556971306;1236.07912105482;23658.870701636934;24177.39556511031;24665.38336541529;27816.582751259153;29532.114036578936;43073;43843.12313753771;43866.12267754563;43934.78032609817;43969.680909571485;237115;239905;240688;240729;240756;30317.69682303149;34708;35280.64719352876;35873.64126358703;36304.63695363013;36673.63326366702;38008.80995595004;38271;38405.6159438402;38436.42345364766;34090.65909340875;35229.647703522634;35613.64386356103;35831;35886;29875.103746887627;30160.3967920636;30249.546256805726;30320;30464.69535304707;29919.70080299169;30115;30186.84906575453;31583.36833263368;32889.17777055497;28065.43869122647;29288.707112928598;29383.853080734458;29594.260143495725;29949.401011979204;23231.53536929218;23268.76731232666;23312.3006309811;23475.647865282375;23596.882015589814 08:55:01 INFO - PROCESS | 17285 | |2;jquery.html;324.7564326754934;330.6709823725393;343.21061558415636;349.55431824423874;351.4517352929429;14386.928065359672;14919.254037298133;15395.923020384911;15401.845981540195;15443.45947891824;14748.852511474883;15015.249237538133;15230.162341071236;15902.88679792415;15908.840911590909;5063.924041139386;5171.276021357013;5224.39919409269;5230.398504172031;5239.685618862862;4982.103221420143;4987.376577927759;5128.384593848743;5145.974270128644;5175.146100893348;5073.594112470993;5076;5079.593632509409;5083.898322033557;5099.6685215460875;5030.496950304977;5059.367579052619;5061.240813877911;5232.450592687789;5235.345581802275;5115.923261151086;5121.103806833789;5122.590192784568;5127.846164615067;5147.459516750725;12134.878651213463;13534.526291579847;19265.13306901193;19288.61422771551;19305.613887722167;1776.875618706691;1777.1025632055857;1798.199801088516;1817.4638481647946;1824.6703797166028;8917.509536975529;8933.910660893438;9252.39859409143;9333.393329433566;9402.670906518308;1777.8577713782995;1819.954501137469;1824.3797108982876;1825.4614888607894;1842.9078546072776;42098.1580368394;47014.05971880577;50408.495915040745;52437.213441798405;54421.455785442035;9476.289278304155;9825.115739583473;9882.851757223647;9966.20270378368;10003.149732272694;11169.162312826407;12720.363981800872;12763.808542871864;12804.487820487077;21569.568608628055;7832.4908880923695;7937.2459616336355;8128.309093726981;8147.388945828968;8380.748577542683;6705.798826035227;6904.965475172592;6941.097657304518;7086.901530262818;7277.89083163753;7401.222871598405;7527.774166775005;7647.388208943271;7702.807429814299;7721.150673425918;2824.209221418006;2881.7982741207916;2937.735603795669;2982.6122604061766;3036.377542603805;769.7152053740152;803.4014659079023;875.9518226497604;907.464595888429;911.5943405184762;15130.697386052218;15653;15801.209939502978;15803.13082780435;15875.364985400454;815.7348861619997;824.468217999387;837.815680550278;857.6269322844582;905.8731777551149;8814.294856411472;8867.689630863018;8938.284937205139;8989.235914947172;8991.82016359669;360041;371472;385677;385974;386109;52361.21458178131;58438.7078064607;62262;65578.67210664012;65809.34190658128;809.2756982500629;885.2961895293257;908.7682640926521;914.1726737302752;920.6271460058687;10907.618233361794;13617.114887532278;13711.177329360271;13716.451341946211;13766.793498097337;27281;27429.17712468629;27566.5865012029;28594.428111438072;29087;33099.33801323912;34176.82911585426;35294.29411411706;35681.82159089188;35739.64260357363;6804.795856124324;6905.274946130785;7006.9649651751415;7118.85762284741;7129.893051604334;7572.4699271052705;7585.051868516435;7768.417368697484;10752.946235268773;11042.227044107156;9388.179328816177;9431.434113953184;9466.715998520056;9477.478738669164;9481.09929556691;9456.858147127936;9525.523723813643;9602.231821454407;9649.855252171363;9773.511324433892;8831.116888311375;9422.670206542738;9672.903270967481;9784.119429251401;9820.607175712892;6945.652717364011;6998.090248267897;7022.12223472066;7109.146902371748;7173.892391614026;8054;9154.862677059717;9332.906670933204;9424.62301507932;9486.667966621411 08:55:01 INFO - PROCESS | 17285 | |3;mootools.html;1225.552673274254;1373.996982202992;1386.6602682342825;1527.2516466931206;1748.6415284866596;6278.372162783719;7239.239879812623;7378.594177320245;7393.963030184848;7401.481896267263;7245.6377181141;7386.556806591609;7434.256574342563;7441.069866266716;7441.255874412556;1817.818218178185;2094.1204694028543;2144.378130342199;2163.1779923629;2164.1559791681257;2148.709924160234;2170.7612162662094;2171.619966505863;2172.663237198229;2174.5324755177635;2077.5740973100555;2096.2767845093417;2099.548597051641;2099.706041154232;2100.9894950525304;2084.0830034784644;2091.665333546633;2120.639491286485;2125.6705210692367;2130.946726331839;2126.138913739938;2135.679648052789;2143.1534543855246;2154.3859999899955;2156.4177672028623;7573.394128469764;7640.312371886557;7651.693932242703;7652.349550288232;7655.464117511777;4336.804843782006;4416;4446.244138496463;4446.755428451466;4450.688451808374;2848.3591191981845;2884.39427720179;2940.779441541893;2949.5428208627695;2976.523756198998;935.6023689931752;937.1518775508176;951.2342564235787;956.3449037409397;978.6672531339308;10605.734856628646;10608;10626;10636.36181829085;10640.46797660114;3910.198409326081;3947.921041579152;4035.6973227008093;4047.291723948297;4053.250148722496;8850.822983540293;8885.733427997171;8933.597988090421;8943.060978597283;8961.103889610988;3743.8502459901842;4389.253826849444;4400.625946794558;4400.75795831226;4403.097365040159;3855.8264878079995;3863.5750067492554;3881.146147847469;3905.2970465316516;3924.372100463912;3374.7300215983155;3458.8616455342008;3469.254110366233;3491.668291512353;3507.438809790421;1115.6485707002269;1122.8764835868049;1123.3316176874746;1126.583164229224;1129.203911242572;1156.3567305828071;1158.4034222375483;1176.688177632928;1179.1451197881468;1194.8625908020515;7002.544834585736;7088.92911070893;7100.3609675128455;7125.786226413215;7152.499325047197;443.7581518072658;450.8354450625498;451.98644040678175;456.15155810193016;462.17040412459716;5372.409035006146;5373.489518495737;5393.703346315911;5436.646617969819;5438.102713052302;8919.464832110094;9198.816023679488;9245.953770231106;9334.766630834147;9428.292878034175;9183.357164998386;9202.861957070649;9226.07739226072;9322.25421966241;9341.813163736688;7047.119110111236;7122.679479423438;7216.170140433917;7221.133463984355;7259.237780033126;6819.795406137824;6841.760538381132;6855;6890.173179218526;6892.276310987274;8021.8395632088195;8148.307393871587;8157.102718700819;8158.551279679675;8339.708110216114;8267.917320826715;8609.440386374865;8619.6983105591;8629.39594228423;8630.482171069756;6403.583767055126;6407.359264073555;6579.111819904251;6605.57063790852;6612.437942774725;7204.639768011473;7205.279472052753;7237.529560578546;7250.854982900418;7267.0552828132;6502.154719886385;6651.833704157435;6657.500687448558;6748.595084294958;6787.830304242236;6452.548321617442;6548.0832683423405;6561.278259391559;6596.7031483584315;6608.471322294301;6712.731490740316;6738.528303018938;6754.8649027020165;6757.797266082025;6770.52606317553;6276.780312689034;6361.173047503795;6367.458766004941;6390.648514331757;6426.903596446151;6470.28826829039;6517.250516190698;6551.21385433751;6552.08270842092;6556.803295901131 08:55:01 INFO - PROCESS | 17285 | |4;prototype.html;303.2903006963704;306.12753652091544;308.5587609718103;317.8283726787535;320.51122038890674;5260.264112842762;5407;5438.91841622375;5449.04641687704;5458.590605704578;5309.070912590291;5334.0398728229;5348.946510534894;5368.087425137726;5433.809816656418;3931.410288456726;4003.5395929468045;4102.17956408718;4174.999999999993;4186.74879507229;4105.44576482174;4105.507339119295;4107.835686572534;4108.116754897696;4113.753174809521;4059.391091336294;4066.7763273019973;4078.632923036926;4079.6940229482907;4102.015516276102;3934.075492259331;4061.289274376972;4104.527979282376;4158.4178215049915;4164.063085805669;3650.5071815305123;3654.6710796028483;3661.7802931824176;3674.761140525857;3676.9080772980624;5075.390953085616;5095.159298715707;5100.260462232993;5150.381954165487;5174.896502069938;4841.588464980481;4854.708717476963;4855.465898751135;4857.465678775332;4857.684250523705;5663.348714897798;5663.915041274384;5673.546116310686;5685.204071430003;5686.260786097822;4040.979795101035;4049.898752531181;4059.7361171523758;4060.1879624075304;4062.8984275393054;5678.176664383683;5934.495567876736;5956.97021514894;5959.165716799652;5960.6588517583195;4161.375793630979;4180.122174343361;4182.079942412664;4185.246655602021;4188.769617671057;4244.236037513216;4248.4052232687445;4251.553586873396;4252.936205956913;4254.808533615995;4807.711537307703;4809.687370320918;4813.879653008633;4823.107725070873;4825.613950883921;5646.717664116778;5657.660540367591;5658.179563963285;5659.688717120515;5660.462256085665;1477.3573495529479;1507.7889095526416;1508.1554329575472;1509.3811537269887;1509.5094094419358;945.4847108325979;1003.5433877585681;1031.6595523477235;1034.4724190662666;1041.4272150317447;4813.302071199656;4912.189488734391;4924;4928.112939670894;4946.282788995647;5896.056630939115;5916.349201587822;5919.052951527821;5921.73352199152;5927.110933360031;4935.777889994959;4954.603631709455;4955.727434991038;4961.181405068123;4961.280614310905;3120.921976950549;3170.61952565689;3170.8414579270943;3172.841357932094;3175.063356309894;5534.640248383842;5584;5591.965486385032;5594.692291923983;5601.5238704710555;5893.14549390336;6091.51267898567;6093.29927058394;6096.02463605821;6104.114903338991;5561.193626924073;5575.888482230333;5578.525825304813;5584.636998594997;5595.776168953359;5906.852328691817;5908.734106965111;5910.349861515144;5915.053591425351;5915.201447804491;5765.4811067004175;5778.364379918122;5792.623479473821;5795.82612521625;5796.362400136066;5574.665520068809;5576.33084029919;5585.776568937197;5588.161775733673;5595.216669666332;3865;4007.0583412897363;4011.6991225658776;4042.4744783179176;4047.3928910663635;5833.620814647034;5847.327557330961;5865.824025279248;5877.059670452707;5877.706114694333;5576.804811831566;5612.466815652507;5616.550675945833;5618.381977982337;5619.831405057855;5607.691576963306;5614.831555053355;5616.21373007771;5616.213730077874;5620.325560932714;5350.384705758732;5491.121420572689;5497.835064948058;5511.779528818963;5513.641613295123;5635.154726791015;5650.915236271377;5655.123455864347;5658.519025882846;5661.037623604079;5477.561795056466;5495.368032676133;5498.367687715964;5502.422245664147;5505.366882808528 08:55:01 INFO - PROCESS | 17285 | |5;yui.html;654.3750718064248;680.4930326906452;689.4691087862345;746.727444482764;757.6287619066659;11707.946284834363;11913.404329783509;12498.437570309336;12769.680757981056;12784.488620455171;13311.334433278322;13356.666083347922;13377.59867203983;13405.262710550916;13443.529476468326;610.3743662745699;776.1539921485579;789.8143936175009;805.6495424490336;806.568485860065;794.7536263758253;804.3725893802814;804.6821505505322;804.806846356873;805.4844899264475;837.8282452097305;844.9155084491532;845.188618925832;845.2646197807916;845.733593917917;631.7630888416844;817.5054092274207;833.1876420490034;840.0968958369747;840.2143995364323;610.8869859076041;612.6293592376637;613.8005148326812;614.3856143856144;615.1910238037012;11377.94311028448;11424.828627570592;11435.199536032482;11455.828162577567;11466.369349685763;10947.945260273727;11221.495032723547;11226.66320010401;11239.044681202107;11600.477978490904;9551.235901127962;9766.804663906752;9854.733198101494;9874.9506252469;9917.057879501435;3281.1797050737314;3287.079617707046;3308.983455082733;3328.051505320996;3341.097903566048;39696.801515992236;39884.80057599722;40033;40201;40228.39657405141;8871.245944094824;9274.582643781046;9340.71977840666;9384.95307523458;9579.664711735057;15882.841171588367;15957.20213989296;15989.44036958724;16168.191590420667;16196.514104576881;5876.970615146983;5968.37332080134;5981.79063732776;6193.287771906198;6249.843753906189;3593.3352329819068;3610.3862343401684;3658.8536458541894;3660.9450858237146;3681.4845921571;2595.5068536977915;2609.673790776153;2633.631291619175;2641.6962049364183;2644.246389778904;463.2032903406136;473.8483685220696;480.28917202540435;482.18510716888346;496.44894167474075;429.10745649050523;486.6714967396993;569.8888716700204;584.4389386189306;589.3634874335708;7288.96355518219;7633.389328853678;7668.348190403766;7730.265624765639;7948.443608947434;570.4609144358624;574.3997522588904;577.4110407384528;586.0944840221867;608.6196127420362;3512.631173726773;3558.857645694195;3603.94594081089;3641.963580364162;3664.8534058637356;45682.54317456849;50443;51131.233031504555;51223.48776512262;51316.48683513192;41231;41854.58145418507;41916.580834191875;42258.57741422608;42337.15325693531;38635.2272954545;39020;39187.80406097951;39626.80186599106;39652.801735991714;7176.641167941686;7339.4862359636445;7351.77079188234;7526.285002924714;7555.622218888923;29466;29712;30491.847540762155;30601.387972239987;30617;37152;38147.42778858264;38558.61441385662;38594.6140538591;39110.41334379929;10339.224558158017;10347.534360953625;10373;10419.166466682798;10445.11216546602;10802.89197108019;11232;11288.604898828502;11377.943110284396;11440.71398215018;9340.206082483064;9553.761155971157;10157.18742500613;10359.689209323733;10700.30448020876;10224.948875255575;10729.30259533159;10885.564577416815;11046.834297485384;11186.32882027081;9736.853947190657;10194.592216311561;10528.315659482108;10749.946250268698;10947.959943805326;8605.95697021511;8718.82562348762;8989.685361012333;9218.723438296862;9342.205912497242;8126.593670316579;8588.742337729878;8672.82654346897;9220.170184683142;9466.763330916781 08:55:01 INFO - PROCESS | 17285 | __end_tp_report 08:55:01 INFO - PROCESS | 17285 | __start_cc_report 08:55:01 INFO - PROCESS | 17285 | _x_x_mozilla_cycle_collect,818 08:55:01 INFO - PROCESS | 17285 | __end_cc_report 08:55:01 INFO - PROCESS | 17285 | __startTimestamp1457369701911__endTimestamp 08:55:01 INFO - PROCESS | 17285 | 08:55:01 INFO - PROCESS | 17285 | ------- Summary: start ------- 08:55:01 INFO - PROCESS | 17285 | Number of tests: 6 08:55:01 INFO - PROCESS | 17285 | 08:55:01 INFO - PROCESS | 17285 | [#0] dojo.html Cycles:165 Average:4492.15 Median:4619.35 stddev:458.90 (9.9%) stddev-sans-first:434.57 08:55:01 INFO - PROCESS | 17285 | Values: 2560.4 2632.1 2634.1 2656.5 2672.2 4412.0 4512.1 4526.9 4529.1 4543.4 4520.4 4525.8 4560.2 4576.1 4619.4 4169.3 4174.3 4178.7 4179.3 4324.8 4071.4 4239.7 4287.2 4300.3 4307.9 4141.8 4144.5 4223.8 4239.8 4265.5 4168.2 4196.7 4197.2 4198.5 4238.1 4175.5 4185.7 4189.6 4205.2 4214.9 4338.6 4438.0 4511.6 4556.2 4568.7 4854.4 4856.0 4866.5 4867.8 4908.7 4708.6 4875.1 4885.4 4885.4 4943.3 4465.3 4509.0 4517.5 4545.7 4552.0 4918.2 4929.9 4939.8 4942.8 4984.0 4621.3 4729.5 4742.6 4749.5 4749.8 4860.0 4877.8 4885.6 4886.2 4919.5 4834.6 4834.7 4836.5 4838.7 4845.0 4682.3 4778.5 4798.4 4825.8 4873.2 4063.1 4067.5 4085.9 4087.1 4100.6 3553.7 3570.4 3576.4 3598.9 3614.1 4080.3 4158.1 4184.6 4188.3 4237.6 4865.7 4873.5 4874.6 4893.6 4899.6 4170.9 4180.7 4182.1 4183.5 4223.6 4190.3 4297.4 4320.6 4397.9 4401.5 4610.7 4616.3 4625.4 4627.8 4663.9 4863.4 4871.4 4872.6 4878.0 4917.1 4502.7 4614.2 4647.2 4666.8 4693.2 4809.1 4813.0 4827.9 4830.1 4876.0 4694.2 4890.8 4892.6 4894.6 4942.5 4682.6 4764.2 4764.9 4795.0 4806.9 4682.5 4705.9 4706.1 4706.7 4747.8 4545.4 4607.0 4607.1 4610.8 4651.9 4773.6 4783.0 4790.2 4793.4 4834.4 4648.7 4659.5 4664.7 4665.7 4707.3 08:55:01 INFO - PROCESS | 17285 | 08:55:01 INFO - PROCESS | 17285 | [#1] ext.html Cycles:180 Average:39231.62 Median:19370.29 stddev:60433.73 (312.0%) stddev-sans-first:60533.26 08:55:01 INFO - PROCESS | 17285 | Values: 492.2 492.2 512.9 525.6 539.3 24000.6 31901.7 32319.8 32414.2 32415.5 35758.3 36237.0 36262.3 36263.0 36281.3 6726.2 7664.6 7850.3 7850.3 9518.4 9720.6 9873.5 9887.9 9893.1 9900.3 9824.6 9946.7 9947.7 9949.3 9958.0 9747.5 9851.5 9854.4 9856.9 9861.2 9641.8 10040.5 10045.0 10054.9 10056.2 37263.4 37803.0 37885.2 37893.4 37918.8 2869.9 2921.6 2949.1 2950.3 3109.7 28439.6 28584.3 28818.3 29117.4 29909.0 3474.2 3508.5 3510.9 3624.5 3693.3 222655.0 222755.0 222868.9 223561.0 223595.0 51592.0 52432.2 52437.0 52442.7 52522.7 44360.8 45426.0 45522.3 46133.5 46275.8 12909.4 13117.3 13124.2 13129.3 13207.9 8942.6 9653.0 9751.0 9770.6 9801.3 18063.9 18085.5 18234.4 18253.0 18255.1 7352.6 7524.5 7546.7 7637.9 7688.4 818.6 822.7 880.4 944.4 997.8 25569.4 26771.2 26855.1 26858.0 26908.5 915.9 931.8 950.8 961.6 1006.8 13536.2 14176.1 14921.7 15680.6 15886.4 233569.0 236723.0 236775.0 236928.0 237864.0 42751.4 42927.6 43125.0 43173.0 43173.4 1097.7 1159.7 1190.8 1201.8 1236.1 23658.9 24177.4 24665.4 27816.6 29532.1 43073.0 43843.1 43866.1 43934.8 43969.7 237115.0 239905.0 240688.0 240729.0 240756.0 30317.7 34708.0 35280.6 35873.6 36304.6 36673.6 38008.8 38271.0 38405.6 38436.4 34090.7 35229.6 35613.6 35831.0 35886.0 29875.1 30160.4 30249.5 30320.0 30464.7 29919.7 30115.0 30186.8 31583.4 32889.2 28065.4 29288.7 29383.9 29594.3 29949.4 23231.5 23268.8 23312.3 23475.6 23596.9 08:55:01 INFO - PROCESS | 17285 | 08:55:01 INFO - PROCESS | 17285 | [#2] jquery.html Cycles:180 Average:21869.26 Median:5199.77 stddev:61714.11 (1186.9%) stddev-sans-first:61866.03 08:55:01 INFO - PROCESS | 17285 | Values: 324.8 330.7 343.2 349.6 351.5 14386.9 14919.3 15395.9 15401.8 15443.5 14748.9 15015.2 15230.2 15902.9 15908.8 5063.9 5171.3 5224.4 5230.4 5239.7 4982.1 4987.4 5128.4 5146.0 5175.1 5073.6 5076.0 5079.6 5083.9 5099.7 5030.5 5059.4 5061.2 5232.5 5235.3 5115.9 5121.1 5122.6 5127.8 5147.5 12134.9 13534.5 19265.1 19288.6 19305.6 1776.9 1777.1 1798.2 1817.5 1824.7 8917.5 8933.9 9252.4 9333.4 9402.7 1777.9 1820.0 1824.4 1825.5 1842.9 42098.2 47014.1 50408.5 52437.2 54421.5 9476.3 9825.1 9882.9 9966.2 10003.1 11169.2 12720.4 12763.8 12804.5 21569.6 7832.5 7937.2 8128.3 8147.4 8380.7 6705.8 6905.0 6941.1 7086.9 7277.9 7401.2 7527.8 7647.4 7702.8 7721.2 2824.2 2881.8 2937.7 2982.6 3036.4 769.7 803.4 876.0 907.5 911.6 15130.7 15653.0 15801.2 15803.1 15875.4 815.7 824.5 837.8 857.6 905.9 8814.3 8867.7 8938.3 8989.2 8991.8 360041.0 371472.0 385677.0 385974.0 386109.0 52361.2 58438.7 62262.0 65578.7 65809.3 809.3 885.3 908.8 914.2 920.6 10907.6 13617.1 13711.2 13716.5 13766.8 27281.0 27429.2 27566.6 28594.4 29087.0 33099.3 34176.8 35294.3 35681.8 35739.6 6804.8 6905.3 7007.0 7118.9 7129.9 7572.5 7585.1 7768.4 10752.9 11042.2 9388.2 9431.4 9466.7 9477.5 9481.1 9456.9 9525.5 9602.2 9649.9 9773.5 8831.1 9422.7 9672.9 9784.1 9820.6 6945.7 6998.1 7022.1 7109.1 7173.9 8054.0 9154.9 9332.9 9424.6 9486.7 08:55:01 INFO - PROCESS | 17285 | 08:55:01 INFO - PROCESS | 17285 | [#3] mootools.html Cycles:180 Average:5242.93 Median:6405.47 stddev:2817.56 (44.0%) stddev-sans-first:2809.28 08:55:01 INFO - PROCESS | 17285 | Values: 1225.6 1374.0 1386.7 1527.3 1748.6 6278.4 7239.2 7378.6 7394.0 7401.5 7245.6 7386.6 7434.3 7441.1 7441.3 1817.8 2094.1 2144.4 2163.2 2164.2 2148.7 2170.8 2171.6 2172.7 2174.5 2077.6 2096.3 2099.5 2099.7 2101.0 2084.1 2091.7 2120.6 2125.7 2130.9 2126.1 2135.7 2143.2 2154.4 2156.4 7573.4 7640.3 7651.7 7652.3 7655.5 4336.8 4416.0 4446.2 4446.8 4450.7 2848.4 2884.4 2940.8 2949.5 2976.5 935.6 937.2 951.2 956.3 978.7 10605.7 10608.0 10626.0 10636.4 10640.5 3910.2 3947.9 4035.7 4047.3 4053.3 8850.8 8885.7 8933.6 8943.1 8961.1 3743.9 4389.3 4400.6 4400.8 4403.1 3855.8 3863.6 3881.1 3905.3 3924.4 3374.7 3458.9 3469.3 3491.7 3507.4 1115.6 1122.9 1123.3 1126.6 1129.2 1156.4 1158.4 1176.7 1179.1 1194.9 7002.5 7088.9 7100.4 7125.8 7152.5 443.8 450.8 452.0 456.2 462.2 5372.4 5373.5 5393.7 5436.6 5438.1 8919.5 9198.8 9246.0 9334.8 9428.3 9183.4 9202.9 9226.1 9322.3 9341.8 7047.1 7122.7 7216.2 7221.1 7259.2 6819.8 6841.8 6855.0 6890.2 6892.3 8021.8 8148.3 8157.1 8158.6 8339.7 8267.9 8609.4 8619.7 8629.4 8630.5 6403.6 6407.4 6579.1 6605.6 6612.4 7204.6 7205.3 7237.5 7250.9 7267.1 6502.2 6651.8 6657.5 6748.6 6787.8 6452.5 6548.1 6561.3 6596.7 6608.5 6712.7 6738.5 6754.9 6757.8 6770.5 6276.8 6361.2 6367.5 6390.6 6426.9 6470.3 6517.3 6551.2 6552.1 6556.8 08:55:01 INFO - PROCESS | 17285 | 08:55:01 INFO - PROCESS | 17285 | [#4] prototype.html Cycles:180 Average:4700.99 Median:5321.56 stddev:1372.78 (25.8%) stddev-sans-first:1336.35 08:55:01 INFO - PROCESS | 17285 | Values: 303.3 306.1 308.6 317.8 320.5 5260.3 5407.0 5438.9 5449.0 5458.6 5309.1 5334.0 5348.9 5368.1 5433.8 3931.4 4003.5 4102.2 4175.0 4186.7 4105.4 4105.5 4107.8 4108.1 4113.8 4059.4 4066.8 4078.6 4079.7 4102.0 3934.1 4061.3 4104.5 4158.4 4164.1 3650.5 3654.7 3661.8 3674.8 3676.9 5075.4 5095.2 5100.3 5150.4 5174.9 4841.6 4854.7 4855.5 4857.5 4857.7 5663.3 5663.9 5673.5 5685.2 5686.3 4041.0 4049.9 4059.7 4060.2 4062.9 5678.2 5934.5 5957.0 5959.2 5960.7 4161.4 4180.1 4182.1 4185.2 4188.8 4244.2 4248.4 4251.6 4252.9 4254.8 4807.7 4809.7 4813.9 4823.1 4825.6 5646.7 5657.7 5658.2 5659.7 5660.5 1477.4 1507.8 1508.2 1509.4 1509.5 945.5 1003.5 1031.7 1034.5 1041.4 4813.3 4912.2 4924.0 4928.1 4946.3 5896.1 5916.3 5919.1 5921.7 5927.1 4935.8 4954.6 4955.7 4961.2 4961.3 3120.9 3170.6 3170.8 3172.8 3175.1 5534.6 5584.0 5592.0 5594.7 5601.5 5893.1 6091.5 6093.3 6096.0 6104.1 5561.2 5575.9 5578.5 5584.6 5595.8 5906.9 5908.7 5910.3 5915.1 5915.2 5765.5 5778.4 5792.6 5795.8 5796.4 5574.7 5576.3 5585.8 5588.2 5595.2 3865.0 4007.1 4011.7 4042.5 4047.4 5833.6 5847.3 5865.8 5877.1 5877.7 5576.8 5612.5 5616.6 5618.4 5619.8 5607.7 5614.8 5616.2 5616.2 5620.3 5350.4 5491.1 5497.8 5511.8 5513.6 5635.2 5650.9 5655.1 5658.5 5661.0 5477.6 5495.4 5498.4 5502.4 5505.4 08:55:01 INFO - PROCESS | 17285 | 08:55:01 INFO - PROCESS | 17285 | [#5] yui.html Cycles:180 Average:12060.25 Median:42297.87 stddev:13460.25 (31.8%) stddev-sans-first:13470.75 08:55:01 INFO - PROCESS | 17285 | Values: 654.4 680.5 689.5 746.7 757.6 11707.9 11913.4 12498.4 12769.7 12784.5 13311.3 13356.7 13377.6 13405.3 13443.5 610.4 776.2 789.8 805.6 806.6 794.8 804.4 804.7 804.8 805.5 837.8 844.9 845.2 845.3 845.7 631.8 817.5 833.2 840.1 840.2 610.9 612.6 613.8 614.4 615.2 11377.9 11424.8 11435.2 11455.8 11466.4 10947.9 11221.5 11226.7 11239.0 11600.5 9551.2 9766.8 9854.7 9875.0 9917.1 3281.2 3287.1 3309.0 3328.1 3341.1 39696.8 39884.8 40033.0 40201.0 40228.4 8871.2 9274.6 9340.7 9385.0 9579.7 15882.8 15957.2 15989.4 16168.2 16196.5 5877.0 5968.4 5981.8 6193.3 6249.8 3593.3 3610.4 3658.9 3660.9 3681.5 2595.5 2609.7 2633.6 2641.7 2644.2 463.2 473.8 480.3 482.2 496.4 429.1 486.7 569.9 584.4 589.4 7289.0 7633.4 7668.3 7730.3 7948.4 570.5 574.4 577.4 586.1 608.6 3512.6 3558.9 3603.9 3642.0 3664.9 45682.5 50443.0 51131.2 51223.5 51316.5 41231.0 41854.6 41916.6 42258.6 42337.2 38635.2 39020.0 39187.8 39626.8 39652.8 7176.6 7339.5 7351.8 7526.3 7555.6 29466.0 29712.0 30491.8 30601.4 30617.0 37152.0 38147.4 38558.6 38594.6 39110.4 10339.2 10347.5 10373.0 10419.2 10445.1 10802.9 11232.0 11288.6 11377.9 11440.7 9340.2 9553.8 10157.2 10359.7 10700.3 10224.9 10729.3 10885.6 11046.8 11186.3 9736.9 10194.6 10528.3 10749.9 10948.0 8606.0 8718.8 8989.7 9218.7 9342.2 8126.6 8588.7 8672.8 9220.2 9466.8 08:55:01 INFO - PROCESS | 17285 | -------- Summary: end -------- 08:55:01 INFO - PROCESS | 17285 | 08:55:02 INFO - TEST-INFO | 17285: exit 0 08:55:02 INFO - TEST-OK | dromaeo_css | took 1117935ms 08:55:02 INFO - TEST-START | kraken 08:55:02 INFO - operating with platform_type : linux_ 08:55:02 INFO - Initialising browser for kraken test... 08:55:02 INFO - TEST-INFO | started process 17465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBs7CXk/profile http://localhost:39502/getInfo.html) 08:55:06 INFO - PROCESS | 17465 | __metrics Screen width/height:1600/1200 08:55:06 INFO - PROCESS | 17465 | colorDepth:24 08:55:07 INFO - PROCESS | 17465 | Browser inner width/height: 1024/697 08:55:07 INFO - PROCESS | 17465 | __metrics 08:55:08 INFO - PROCESS | 17465 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:09 INFO - TEST-INFO | 17465: exit 0 08:55:09 INFO - Browser initialized. 08:55:09 INFO - Running cycle 1/1 for kraken test... 08:55:09 INFO - TEST-INFO | started process 17547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBs7CXk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:21 INFO - PROCESS | 17547 | RSS: Main: 156352512 08:55:21 INFO - PROCESS | 17547 | 08:55:23 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39502/tests/kraken/driver.html?testName=audio-beat-detection) 08:55:24 INFO - PROCESS | 17547 | RSS: Main: 200589312 08:55:24 INFO - PROCESS | 17547 | 08:55:27 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39502/tests/kraken/driver.html?testName=audio-dft) 08:55:27 INFO - PROCESS | 17547 | RSS: Main: 189321216 08:55:27 INFO - PROCESS | 17547 | 08:55:30 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39502/tests/kraken/driver.html?testName=audio-fft) 08:55:31 INFO - PROCESS | 17547 | RSS: Main: 172548096 08:55:31 INFO - PROCESS | 17547 | 08:55:33 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39502/tests/kraken/driver.html?testName=audio-oscillator) 08:55:33 INFO - PROCESS | 17547 | RSS: Main: 175116288 08:55:33 INFO - PROCESS | 17547 | 08:55:36 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:55:36 INFO - PROCESS | 17547 | RSS: Main: 175980544 08:55:36 INFO - PROCESS | 17547 | 08:55:39 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39502/tests/kraken/driver.html?testName=imaging-darkroom) 08:55:40 INFO - PROCESS | 17547 | RSS: Main: 176324608 08:55:40 INFO - PROCESS | 17547 | 08:55:44 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39502/tests/kraken/driver.html?testName=imaging-desaturate) 08:55:44 INFO - PROCESS | 17547 | RSS: Main: 175644672 08:55:44 INFO - PROCESS | 17547 | 08:55:47 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39502/tests/kraken/driver.html?testName=json-parse-financial) 08:55:48 INFO - PROCESS | 17547 | RSS: Main: 176259072 08:55:48 INFO - PROCESS | 17547 | 08:55:49 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:55:50 INFO - PROCESS | 17547 | RSS: Main: 187027456 08:55:50 INFO - PROCESS | 17547 | 08:55:52 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39502/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:55:53 INFO - PROCESS | 17547 | RSS: Main: 185479168 08:55:53 INFO - PROCESS | 17547 | 08:55:55 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:55:55 INFO - PROCESS | 17547 | RSS: Main: 197558272 08:55:55 INFO - PROCESS | 17547 | 08:55:58 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:55:58 INFO - PROCESS | 17547 | RSS: Main: 201474048 08:55:58 INFO - PROCESS | 17547 | 08:56:01 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:56:02 INFO - PROCESS | 17547 | RSS: Main: 201007104 08:56:02 INFO - PROCESS | 17547 | 08:56:03 INFO - PROCESS | 17547 | Cycle 1(1): loaded http://localhost:39502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39502/tests/kraken/driver.html?testName=ai-astar) 08:56:04 INFO - PROCESS | 17547 | RSS: Main: 261926912 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | __start_tp_report 08:56:04 INFO - PROCESS | 17547 | _x_x_mozilla_page_load 08:56:04 INFO - PROCESS | 17547 | _x_x_mozilla_page_load_details 08:56:04 INFO - PROCESS | 17547 | |i|pagename|runs| 08:56:04 INFO - PROCESS | 17547 | |0;ai-astar;112;114;108;113;114;114;104;112;113;115 08:56:04 INFO - PROCESS | 17547 | |1;audio-beat-detection;156;140;153;186;135;156;163;145;180;131 08:56:04 INFO - PROCESS | 17547 | |2;audio-dft;165;163;161;161;164;164;164;163;163;162 08:56:04 INFO - PROCESS | 17547 | |3;audio-fft;74;80;97;98;74;74;73;111;97;74 08:56:04 INFO - PROCESS | 17547 | |4;audio-oscillator;95;95;146;95;95;95;143;93;95;135 08:56:04 INFO - PROCESS | 17547 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;118;118;117 08:56:04 INFO - PROCESS | 17547 | |6;imaging-darkroom;147;147;148;147;147;147;146;147;148;147 08:56:04 INFO - PROCESS | 17547 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 08:56:04 INFO - PROCESS | 17547 | |8;json-parse-financial;70;69;69;69;68;70;69;80;67;67 08:56:04 INFO - PROCESS | 17547 | |9;json-stringify-tinderbox;70;70;70;69;70;70;70;70;70;70 08:56:04 INFO - PROCESS | 17547 | |10;stanford-crypto-aes;82;82;84;83;83;84;84;84;83;82 08:56:04 INFO - PROCESS | 17547 | |11;stanford-crypto-ccm;127;125;121;121;118;132;120;118;123;120 08:56:04 INFO - PROCESS | 17547 | |12;stanford-crypto-pbkdf2;157;142;142;150;150;140;152;154;148;153 08:56:04 INFO - PROCESS | 17547 | |13;stanford-crypto-sha256-iterative;71;71;72;71;71;70;70;70;71;70 08:56:04 INFO - PROCESS | 17547 | __end_tp_report 08:56:04 INFO - PROCESS | 17547 | __start_cc_report 08:56:04 INFO - PROCESS | 17547 | _x_x_mozilla_cycle_collect,1176 08:56:04 INFO - PROCESS | 17547 | __end_cc_report 08:56:04 INFO - PROCESS | 17547 | __startTimestamp1457369764167__endTimestamp 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | ------- Summary: start ------- 08:56:04 INFO - PROCESS | 17547 | Number of tests: 14 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:3.38 (3.0%) stddev-sans-first:3.59 08:56:04 INFO - PROCESS | 17547 | Values: 112.0 114.0 108.0 113.0 114.0 114.0 104.0 112.0 113.0 115.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:156.00 stddev:18.12 (11.6%) stddev-sans-first:19.21 08:56:04 INFO - PROCESS | 17547 | Values: 156.0 140.0 153.0 186.0 135.0 156.0 163.0 145.0 180.0 131.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:1.33 (0.8%) stddev-sans-first:1.20 08:56:04 INFO - PROCESS | 17547 | Values: 165.0 163.0 161.0 161.0 164.0 164.0 164.0 163.0 163.0 162.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#3] audio-fft Cycles:10 Average:85.20 Median:77.00 stddev:14.09 (18.3%) stddev-sans-first:14.34 08:56:04 INFO - PROCESS | 17547 | Values: 74.0 80.0 97.0 98.0 74.0 74.0 73.0 111.0 97.0 74.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.00 stddev:22.69 (23.9%) stddev-sans-first:23.51 08:56:04 INFO - PROCESS | 17547 | Values: 95.0 95.0 146.0 95.0 95.0 95.0 143.0 93.0 95.0 135.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:56:04 INFO - PROCESS | 17547 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:56:04 INFO - PROCESS | 17547 | Values: 147.0 147.0 148.0 147.0 147.0 147.0 146.0 147.0 148.0 147.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:56:04 INFO - PROCESS | 17547 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#8] json-parse-financial Cycles:10 Average:69.80 Median:69.00 stddev:3.74 (5.4%) stddev-sans-first:3.96 08:56:04 INFO - PROCESS | 17547 | Values: 70.0 69.0 69.0 69.0 68.0 70.0 69.0 80.0 67.0 67.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 08:56:04 INFO - PROCESS | 17547 | Values: 70.0 70.0 70.0 69.0 70.0 70.0 70.0 70.0 70.0 70.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:0.88 (1.0%) stddev-sans-first:0.83 08:56:04 INFO - PROCESS | 17547 | Values: 82.0 82.0 84.0 83.0 83.0 84.0 84.0 84.0 83.0 82.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:122.00 stddev:4.40 (3.6%) stddev-sans-first:4.36 08:56:04 INFO - PROCESS | 17547 | Values: 127.0 125.0 121.0 121.0 118.0 132.0 120.0 118.0 123.0 120.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:151.00 stddev:5.73 (3.8%) stddev-sans-first:5.25 08:56:04 INFO - PROCESS | 17547 | Values: 157.0 142.0 142.0 150.0 150.0 140.0 152.0 154.0 148.0 153.0 08:56:04 INFO - PROCESS | 17547 | 08:56:04 INFO - PROCESS | 17547 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 08:56:04 INFO - PROCESS | 17547 | Values: 71.0 71.0 72.0 71.0 71.0 70.0 70.0 70.0 71.0 70.0 08:56:04 INFO - PROCESS | 17547 | -------- Summary: end -------- 08:56:04 INFO - PROCESS | 17547 | 08:56:05 INFO - TEST-INFO | 17547: exit 0 08:56:05 INFO - TEST-OK | kraken | took 62493ms 08:56:05 INFO - SUITE-END | took 1180s 08:56:05 INFO - Completed test suite (00:19:40) 08:56:05 INFO - javascript benchmark 08:56:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2560.3727086863714, 2632.1313966391094, 2634.1439032314493, 2656.4687062587486, 2672.2384120525653, 4411.977940110303, 4512.1426928883575, 4526.932096018558, 4529.116822219665, 4543.386642803221, 4520.434945631796, 4525.751083690396, 4560.2475591527445, 4576.13053519831, 4619.353290539327, 4169.270377683908, 4174.31123864562, 4178.749275043492, 4179.33130699089, 4324.827006919735, 4071.42999980003, 4239.703220774547, 4287.164003019397, 4300.311950087987, 4307.892302692427, 4141.7514949103, 4144.544100148981, 4223.809928553223, 4239.830406783725, 4265.466816647919, 4168.166366726667, 4196.727212731163, 4197.244495990721, 4198.475190601175, 4238.067625122499, 4175.519815221258, 4185.707000509966, 4189.6438802701805, 4205.158968206371, 4214.852480163179, 4338.566143385668, 4438.045820148684, 4511.6165125964335, 4556.225441674923, 4568.680192386534, 4854.417469903598, 4855.951440485585, 4866.489018653026, 4867.756612169377, 4908.656394052417, 4708.552687494683, 4875.098106850209, 4885.389326334208, 4885.389326334208, 4943.283223932545, 4465.263231566788, 4508.985478267429, 4517.480489743722, 4545.749983750892, 4551.977240113778, 4918.1884988977135, 4929.901401971941, 4939.753012349368, 4942.827001055018, 4983.950160498349, 4621.2837010263465, 4729.5034021427255, 4742.596879265301, 4749.525047495223, 4749.833755818529, 4860.0, 4877.804887804519, 4885.560299573055, 4886.193778026657, 4919.532644398776, 4834.589059929875, 4834.734089625034, 4836.516348365206, 4838.7338696372035, 4844.95155048445, 4682.2508398656055, 4778.474367819537, 4798.424189097331, 4825.782839772219, 4873.244647079709, 4063.065494936181, 4067.4508941292547, 4085.85699500522, 4087.1008378156757, 4100.569440208795, 3553.6979356754964, 3570.4465807799834, 3576.3741345264475, 3598.8560457581925, 3614.1145419372424, 4080.326746086922, 4158.106007208404, 4184.560621134798, 4188.32986722123, 4237.5762423758, 4865.732384718804, 4873.463918968911, 4874.634402419832, 4893.559579637849, 4899.58353539946, 4170.874873753793, 4180.749155050707, 4182.1008483176265, 4183.477065366829, 4223.598758117974, 4190.28765109932, 4297.376880352332, 4320.632746216544, 4397.912041759147, 4401.493828209733, 4610.654200934876, 4616.28447590624, 4625.352450656911, 4627.768611569475, 4663.930041049455, 4863.392075990501, 4871.3667223260745, 4872.561469467765, 4878.0, 4917.114919314415, 4502.662300327423, 4614.192516309699, 4647.233206520887, 4666.789994450326, 4693.22561777303, 4809.134355815987, 4813.03739252158, 4827.903441931212, 4830.106430310404, 4876.024795040935, 4694.155052090657, 4890.828820991248, 4892.633052521146, 4894.608431325414, 4942.481039490802, 4682.648801339845, 4764.213904705824, 4764.904701906012, 4794.976025119991, 4806.903861922812, 4682.531746825291, 4705.882352941204, 4706.0823139487475, 4706.717596944194, 4747.83382581608, 4545.363649089064, 4607.032523170172, 4607.14767767964, 4610.79251433693, 4651.906961860676, 4773.594244489118, 4782.976085119552, 4790.209615413418, 4793.424789025339, 4834.371531700856, 4648.674592778473, 4659.534046595313, 4664.650151238603, 4665.650076244363, 4707.270373092176], "unit": "score", "name": "dojo.html", "value": 4464.154979237944}, {"lowerIsBetter": false, "replicates": [492.1731491094959, 492.20017471608656, 512.8922926185501, 525.618926278448, 539.2665974274987, 24000.63999040016, 31901.680983190192, 32319.838400807963, 32414.18964525888, 32415.51376729345, 35758.2848343033, 36237.0, 36262.27475450489, 36263.0, 36281.2743745125, 6726.192856857184, 7664.616769161547, 7850.254225848564, 7850.3327217186325, 9518.428894266366, 9720.562574684122, 9873.506324683736, 9887.90112098877, 9893.109620134186, 9900.306978511508, 9824.557894894711, 9946.65186718465, 9947.701568952907, 9949.253805964545, 9957.950210248939, 9747.463889486075, 9851.458169800659, 9854.359466634645, 9856.901430985741, 9861.211103111806, 9641.758956026086, 10040.544121102472, 10045.0, 10054.9497252514, 10056.195504359634, 37263.441048384295, 37803.0, 37885.24229515422, 37893.43159852605, 37918.81040594779, 2869.9426011479864, 2921.6201893753678, 2949.130006648044, 2950.262434391402, 3109.70457806508, 28439.573406398922, 28584.28539286514, 28818.279543011384, 29117.41765164706, 29909.0, 3474.1662001119803, 3508.4912687660403, 3510.9297814043575, 3624.4563315502887, 3693.279810436966, 222655.0, 222755.0, 222868.88565557232, 223561.0, 223595.0, 51592.0, 52432.21351679728, 52437.0, 52442.73778631083, 52522.73738631282, 44360.77819610946, 45426.0, 45522.317165242544, 46133.538664613596, 46275.768621156676, 12909.419076141596, 13117.278549679859, 13124.212547247005, 13129.277889716157, 13207.933960330136, 8942.642294308285, 9653.0, 9751.0, 9770.560324785401, 9801.31390802637, 18063.909680451514, 18085.457436276934, 18234.36179733703, 18252.996085215174, 18255.08724563793, 7352.63236838156, 7524.473286869867, 7546.660400282, 7637.923620763832, 7688.423368247404, 818.5784321074651, 822.6750433578703, 880.4321212817697, 944.4003058058045, 997.8004399120205, 25569.37264216824, 26771.19686409411, 26855.060072897744, 26858.0, 26908.461830763274, 915.8809354783835, 931.7856892914667, 950.7813202963357, 961.624966263158, 1006.8389057750725, 13536.187828730308, 14176.149431033964, 14921.70156596862, 15680.607984800243, 15886.364545418053, 233569.0, 236723.0, 236775.0, 236928.0, 237864.0, 42751.35872961908, 42927.57072429298, 43125.0, 43173.0, 43173.35239971403, 1097.742030622819, 1159.7332613498943, 1190.7856585814463, 1201.7656556971306, 1236.07912105482, 23658.870701636934, 24177.39556511031, 24665.38336541529, 27816.582751259153, 29532.114036578936, 43073.0, 43843.12313753771, 43866.12267754563, 43934.78032609817, 43969.680909571485, 237115.0, 239905.0, 240688.0, 240729.0, 240756.0, 30317.69682303149, 34708.0, 35280.64719352876, 35873.64126358703, 36304.63695363013, 36673.63326366702, 38008.80995595004, 38271.0, 38405.6159438402, 38436.42345364766, 34090.65909340875, 35229.647703522634, 35613.64386356103, 35831.0, 35886.0, 29875.103746887627, 30160.3967920636, 30249.546256805726, 30320.0, 30464.69535304707, 29919.70080299169, 30115.0, 30186.84906575453, 31583.36833263368, 32889.17777055497, 28065.43869122647, 29288.707112928598, 29383.853080734458, 29594.260143495725, 29949.401011979204, 23231.53536929218, 23268.76731232666, 23312.3006309811, 23475.647865282375, 23596.882015589814], "unit": "score", "name": "ext.html", "value": 16864.01359679841}, {"lowerIsBetter": false, "replicates": [324.7564326754934, 330.6709823725393, 343.21061558415636, 349.55431824423874, 351.4517352929429, 14386.928065359672, 14919.254037298133, 15395.923020384911, 15401.845981540195, 15443.45947891824, 14748.852511474883, 15015.249237538133, 15230.162341071236, 15902.88679792415, 15908.840911590909, 5063.924041139386, 5171.276021357013, 5224.39919409269, 5230.398504172031, 5239.685618862862, 4982.103221420143, 4987.376577927759, 5128.384593848743, 5145.974270128644, 5175.146100893348, 5073.594112470993, 5076.0, 5079.593632509409, 5083.898322033557, 5099.6685215460875, 5030.496950304977, 5059.367579052619, 5061.240813877911, 5232.450592687789, 5235.345581802275, 5115.923261151086, 5121.103806833789, 5122.590192784568, 5127.846164615067, 5147.459516750725, 12134.878651213463, 13534.526291579847, 19265.13306901193, 19288.61422771551, 19305.613887722167, 1776.875618706691, 1777.1025632055857, 1798.199801088516, 1817.4638481647946, 1824.6703797166028, 8917.509536975529, 8933.910660893438, 9252.39859409143, 9333.393329433566, 9402.670906518308, 1777.8577713782995, 1819.954501137469, 1824.3797108982876, 1825.4614888607894, 1842.9078546072776, 42098.1580368394, 47014.05971880577, 50408.495915040745, 52437.213441798405, 54421.455785442035, 9476.289278304155, 9825.115739583473, 9882.851757223647, 9966.20270378368, 10003.149732272694, 11169.162312826407, 12720.363981800872, 12763.808542871864, 12804.487820487077, 21569.568608628055, 7832.4908880923695, 7937.2459616336355, 8128.309093726981, 8147.388945828968, 8380.748577542683, 6705.798826035227, 6904.965475172592, 6941.097657304518, 7086.901530262818, 7277.89083163753, 7401.222871598405, 7527.774166775005, 7647.388208943271, 7702.807429814299, 7721.150673425918, 2824.209221418006, 2881.7982741207916, 2937.735603795669, 2982.6122604061766, 3036.377542603805, 769.7152053740152, 803.4014659079023, 875.9518226497604, 907.464595888429, 911.5943405184762, 15130.697386052218, 15653.0, 15801.209939502978, 15803.13082780435, 15875.364985400454, 815.7348861619997, 824.468217999387, 837.815680550278, 857.6269322844582, 905.8731777551149, 8814.294856411472, 8867.689630863018, 8938.284937205139, 8989.235914947172, 8991.82016359669, 360041.0, 371472.0, 385677.0, 385974.0, 386109.0, 52361.21458178131, 58438.7078064607, 62262.0, 65578.67210664012, 65809.34190658128, 809.2756982500629, 885.2961895293257, 908.7682640926521, 914.1726737302752, 920.6271460058687, 10907.618233361794, 13617.114887532278, 13711.177329360271, 13716.451341946211, 13766.793498097337, 27281.0, 27429.17712468629, 27566.5865012029, 28594.428111438072, 29087.0, 33099.33801323912, 34176.82911585426, 35294.29411411706, 35681.82159089188, 35739.64260357363, 6804.795856124324, 6905.274946130785, 7006.9649651751415, 7118.85762284741, 7129.893051604334, 7572.4699271052705, 7585.051868516435, 7768.417368697484, 10752.946235268773, 11042.227044107156, 9388.179328816177, 9431.434113953184, 9466.715998520056, 9477.478738669164, 9481.09929556691, 9456.858147127936, 9525.523723813643, 9602.231821454407, 9649.855252171363, 9773.511324433892, 8831.116888311375, 9422.670206542738, 9672.903270967481, 9784.119429251401, 9820.607175712892, 6945.652717364011, 6998.090248267897, 7022.12223472066, 7109.146902371748, 7173.892391614026, 8054.0, 9154.862677059717, 9332.906670933204, 9424.62301507932, 9486.667966621411], "unit": "score", "name": "jquery.html", "value": 7764.704373925159}, {"lowerIsBetter": false, "replicates": [1225.552673274254, 1373.996982202992, 1386.6602682342825, 1527.2516466931206, 1748.6415284866596, 6278.372162783719, 7239.239879812623, 7378.594177320245, 7393.963030184848, 7401.481896267263, 7245.6377181141, 7386.556806591609, 7434.256574342563, 7441.069866266716, 7441.255874412556, 1817.818218178185, 2094.1204694028543, 2144.378130342199, 2163.1779923629, 2164.1559791681257, 2148.709924160234, 2170.7612162662094, 2171.619966505863, 2172.663237198229, 2174.5324755177635, 2077.5740973100555, 2096.2767845093417, 2099.548597051641, 2099.706041154232, 2100.9894950525304, 2084.0830034784644, 2091.665333546633, 2120.639491286485, 2125.6705210692367, 2130.946726331839, 2126.138913739938, 2135.679648052789, 2143.1534543855246, 2154.3859999899955, 2156.4177672028623, 7573.394128469764, 7640.312371886557, 7651.693932242703, 7652.349550288232, 7655.464117511777, 4336.804843782006, 4416.0, 4446.244138496463, 4446.755428451466, 4450.688451808374, 2848.3591191981845, 2884.39427720179, 2940.779441541893, 2949.5428208627695, 2976.523756198998, 935.6023689931752, 937.1518775508176, 951.2342564235787, 956.3449037409397, 978.6672531339308, 10605.734856628646, 10608.0, 10626.0, 10636.36181829085, 10640.46797660114, 3910.198409326081, 3947.921041579152, 4035.6973227008093, 4047.291723948297, 4053.250148722496, 8850.822983540293, 8885.733427997171, 8933.597988090421, 8943.060978597283, 8961.103889610988, 3743.8502459901842, 4389.253826849444, 4400.625946794558, 4400.75795831226, 4403.097365040159, 3855.8264878079995, 3863.5750067492554, 3881.146147847469, 3905.2970465316516, 3924.372100463912, 3374.7300215983155, 3458.8616455342008, 3469.254110366233, 3491.668291512353, 3507.438809790421, 1115.6485707002269, 1122.8764835868049, 1123.3316176874746, 1126.583164229224, 1129.203911242572, 1156.3567305828071, 1158.4034222375483, 1176.688177632928, 1179.1451197881468, 1194.8625908020515, 7002.544834585736, 7088.92911070893, 7100.3609675128455, 7125.786226413215, 7152.499325047197, 443.7581518072658, 450.8354450625498, 451.98644040678175, 456.15155810193016, 462.17040412459716, 5372.409035006146, 5373.489518495737, 5393.703346315911, 5436.646617969819, 5438.102713052302, 8919.464832110094, 9198.816023679488, 9245.953770231106, 9334.766630834147, 9428.292878034175, 9183.357164998386, 9202.861957070649, 9226.07739226072, 9322.25421966241, 9341.813163736688, 7047.119110111236, 7122.679479423438, 7216.170140433917, 7221.133463984355, 7259.237780033126, 6819.795406137824, 6841.760538381132, 6855.0, 6890.173179218526, 6892.276310987274, 8021.8395632088195, 8148.307393871587, 8157.102718700819, 8158.551279679675, 8339.708110216114, 8267.917320826715, 8609.440386374865, 8619.6983105591, 8629.39594228423, 8630.482171069756, 6403.583767055126, 6407.359264073555, 6579.111819904251, 6605.57063790852, 6612.437942774725, 7204.639768011473, 7205.279472052753, 7237.529560578546, 7250.854982900418, 7267.0552828132, 6502.154719886385, 6651.833704157435, 6657.500687448558, 6748.595084294958, 6787.830304242236, 6452.548321617442, 6548.0832683423405, 6561.278259391559, 6596.7031483584315, 6608.471322294301, 6712.731490740316, 6738.528303018938, 6754.8649027020165, 6757.797266082025, 6770.52606317553, 6276.780312689034, 6361.173047503795, 6367.458766004941, 6390.648514331757, 6426.903596446151, 6470.28826829039, 6517.250516190698, 6551.21385433751, 6552.08270842092, 6556.803295901131], "unit": "score", "name": "mootools.html", "value": 4193.843363404992}, {"lowerIsBetter": false, "replicates": [303.2903006963704, 306.12753652091544, 308.5587609718103, 317.8283726787535, 320.51122038890674, 5260.264112842762, 5407.0, 5438.91841622375, 5449.04641687704, 5458.590605704578, 5309.070912590291, 5334.0398728229, 5348.946510534894, 5368.087425137726, 5433.809816656418, 3931.410288456726, 4003.5395929468045, 4102.17956408718, 4174.999999999993, 4186.74879507229, 4105.44576482174, 4105.507339119295, 4107.835686572534, 4108.116754897696, 4113.753174809521, 4059.391091336294, 4066.7763273019973, 4078.632923036926, 4079.6940229482907, 4102.015516276102, 3934.075492259331, 4061.289274376972, 4104.527979282376, 4158.4178215049915, 4164.063085805669, 3650.5071815305123, 3654.6710796028483, 3661.7802931824176, 3674.761140525857, 3676.9080772980624, 5075.390953085616, 5095.159298715707, 5100.260462232993, 5150.381954165487, 5174.896502069938, 4841.588464980481, 4854.708717476963, 4855.465898751135, 4857.465678775332, 4857.684250523705, 5663.348714897798, 5663.915041274384, 5673.546116310686, 5685.204071430003, 5686.260786097822, 4040.979795101035, 4049.898752531181, 4059.7361171523758, 4060.1879624075304, 4062.8984275393054, 5678.176664383683, 5934.495567876736, 5956.97021514894, 5959.165716799652, 5960.6588517583195, 4161.375793630979, 4180.122174343361, 4182.079942412664, 4185.246655602021, 4188.769617671057, 4244.236037513216, 4248.4052232687445, 4251.553586873396, 4252.936205956913, 4254.808533615995, 4807.711537307703, 4809.687370320918, 4813.879653008633, 4823.107725070873, 4825.613950883921, 5646.717664116778, 5657.660540367591, 5658.179563963285, 5659.688717120515, 5660.462256085665, 1477.3573495529479, 1507.7889095526416, 1508.1554329575472, 1509.3811537269887, 1509.5094094419358, 945.4847108325979, 1003.5433877585681, 1031.6595523477235, 1034.4724190662666, 1041.4272150317447, 4813.302071199656, 4912.189488734391, 4924.0, 4928.112939670894, 4946.282788995647, 5896.056630939115, 5916.349201587822, 5919.052951527821, 5921.73352199152, 5927.110933360031, 4935.777889994959, 4954.603631709455, 4955.727434991038, 4961.181405068123, 4961.280614310905, 3120.921976950549, 3170.61952565689, 3170.8414579270943, 3172.841357932094, 3175.063356309894, 5534.640248383842, 5584.0, 5591.965486385032, 5594.692291923983, 5601.5238704710555, 5893.14549390336, 6091.51267898567, 6093.29927058394, 6096.02463605821, 6104.114903338991, 5561.193626924073, 5575.888482230333, 5578.525825304813, 5584.636998594997, 5595.776168953359, 5906.852328691817, 5908.734106965111, 5910.349861515144, 5915.053591425351, 5915.201447804491, 5765.4811067004175, 5778.364379918122, 5792.623479473821, 5795.82612521625, 5796.362400136066, 5574.665520068809, 5576.33084029919, 5585.776568937197, 5588.161775733673, 5595.216669666332, 3865.0, 4007.0583412897363, 4011.6991225658776, 4042.4744783179176, 4047.3928910663635, 5833.620814647034, 5847.327557330961, 5865.824025279248, 5877.059670452707, 5877.706114694333, 5576.804811831566, 5612.466815652507, 5616.550675945833, 5618.381977982337, 5619.831405057855, 5607.691576963306, 5614.831555053355, 5616.21373007771, 5616.213730077874, 5620.325560932714, 5350.384705758732, 5491.121420572689, 5497.835064948058, 5511.779528818963, 5513.641613295123, 5635.154726791015, 5650.915236271377, 5655.123455864347, 5658.519025882846, 5661.037623604079, 5477.561795056466, 5495.368032676133, 5498.367687715964, 5502.422245664147, 5505.366882808528], "unit": "score", "name": "prototype.html", "value": 4263.696832585179}, {"lowerIsBetter": false, "replicates": [654.3750718064248, 680.4930326906452, 689.4691087862345, 746.727444482764, 757.6287619066659, 11707.946284834363, 11913.404329783509, 12498.437570309336, 12769.680757981056, 12784.488620455171, 13311.334433278322, 13356.666083347922, 13377.59867203983, 13405.262710550916, 13443.529476468326, 610.3743662745699, 776.1539921485579, 789.8143936175009, 805.6495424490336, 806.568485860065, 794.7536263758253, 804.3725893802814, 804.6821505505322, 804.806846356873, 805.4844899264475, 837.8282452097305, 844.9155084491532, 845.188618925832, 845.2646197807916, 845.733593917917, 631.7630888416844, 817.5054092274207, 833.1876420490034, 840.0968958369747, 840.2143995364323, 610.8869859076041, 612.6293592376637, 613.8005148326812, 614.3856143856144, 615.1910238037012, 11377.94311028448, 11424.828627570592, 11435.199536032482, 11455.828162577567, 11466.369349685763, 10947.945260273727, 11221.495032723547, 11226.66320010401, 11239.044681202107, 11600.477978490904, 9551.235901127962, 9766.804663906752, 9854.733198101494, 9874.9506252469, 9917.057879501435, 3281.1797050737314, 3287.079617707046, 3308.983455082733, 3328.051505320996, 3341.097903566048, 39696.801515992236, 39884.80057599722, 40033.0, 40201.0, 40228.39657405141, 8871.245944094824, 9274.582643781046, 9340.71977840666, 9384.95307523458, 9579.664711735057, 15882.841171588367, 15957.20213989296, 15989.44036958724, 16168.191590420667, 16196.514104576881, 5876.970615146983, 5968.37332080134, 5981.79063732776, 6193.287771906198, 6249.843753906189, 3593.3352329819068, 3610.3862343401684, 3658.8536458541894, 3660.9450858237146, 3681.4845921571, 2595.5068536977915, 2609.673790776153, 2633.631291619175, 2641.6962049364183, 2644.246389778904, 463.2032903406136, 473.8483685220696, 480.28917202540435, 482.18510716888346, 496.44894167474075, 429.10745649050523, 486.6714967396993, 569.8888716700204, 584.4389386189306, 589.3634874335708, 7288.96355518219, 7633.389328853678, 7668.348190403766, 7730.265624765639, 7948.443608947434, 570.4609144358624, 574.3997522588904, 577.4110407384528, 586.0944840221867, 608.6196127420362, 3512.631173726773, 3558.857645694195, 3603.94594081089, 3641.963580364162, 3664.8534058637356, 45682.54317456849, 50443.0, 51131.233031504555, 51223.48776512262, 51316.48683513192, 41231.0, 41854.58145418507, 41916.580834191875, 42258.57741422608, 42337.15325693531, 38635.2272954545, 39020.0, 39187.80406097951, 39626.80186599106, 39652.801735991714, 7176.641167941686, 7339.4862359636445, 7351.77079188234, 7526.285002924714, 7555.622218888923, 29466.0, 29712.0, 30491.847540762155, 30601.387972239987, 30617.0, 37152.0, 38147.42778858264, 38558.61441385662, 38594.6140538591, 39110.41334379929, 10339.224558158017, 10347.534360953625, 10373.0, 10419.166466682798, 10445.11216546602, 10802.89197108019, 11232.0, 11288.604898828502, 11377.943110284396, 11440.71398215018, 9340.206082483064, 9553.761155971157, 10157.18742500613, 10359.689209323733, 10700.30448020876, 10224.948875255575, 10729.30259533159, 10885.564577416815, 11046.834297485384, 11186.32882027081, 9736.853947190657, 10194.592216311561, 10528.315659482108, 10749.946250268698, 10947.959943805326, 8605.95697021511, 8718.82562348762, 8989.685361012333, 9218.723438296862, 9342.205912497242, 8126.593670316579, 8588.742337729878, 8672.82654346897, 9220.170184683142, 9466.763330916781], "unit": "score", "name": "yui.html", "value": 5660.2347952421505}], "name": "dromaeo_css", "value": 6242.38132565916}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 113.0, 114.0, 114.0, 104.0, 112.0, 113.0, 115.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [156.0, 140.0, 153.0, 186.0, 135.0, 156.0, 163.0, 145.0, 180.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 154.5}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 161.0, 161.0, 164.0, 164.0, 164.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [74.0, 80.0, 97.0, 98.0, 74.0, 74.0, 73.0, 111.0, 97.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 146.0, 95.0, 95.0, 95.0, 143.0, 93.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 69.0, 68.0, 70.0, 69.0, 80.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 69.8}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 84.0, 83.0, 83.0, 84.0, 84.0, 84.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [127.0, 125.0, 121.0, 121.0, 118.0, 132.0, 120.0, 118.0, 123.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [157.0, 142.0, 142.0, 150.0, 150.0, 140.0, 152.0, 154.0, 148.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 71.0, 71.0, 70.0, 70.0, 70.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1547.4}]} 08:56:05 INFO - Return code: 0 08:56:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:56:05 INFO - # TBPL SUCCESS # 08:56:05 INFO - Running post-action listener: _resource_record_post_action 08:56:05 INFO - Running post-run listener: _resource_record_post_run 08:56:06 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 522149888; Read time: 356; Write time: 839712 08:56:06 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233697280; Read time: 0; Write time: 471204 08:56:06 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288452608; Read time: 356; Write time: 368508 08:56:06 INFO - Running post-run listener: _upload_blobber_files 08:56:06 INFO - Blob upload gear active. 08:56:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:56:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:56:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:56:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:56:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:07 INFO - (blobuploader) - INFO - Done attempting. 08:56:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:56:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:56:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:08 INFO - (blobuploader) - INFO - Done attempting. 08:56:08 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:08 INFO - Return code: 0 08:56:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:56:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d18174b27f9f4e2095c7820639f8d6464719212f7b11c694414b02e0d2bf14f63f77d5861947326289725bfe4207a9b75b558d9e05f0c07eb44838963a2e637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab3ed3045290995fbb8e2320e0beecf60328f78d2de06443140b2d34cb1c8cd6170c5a9add876edc5de2009b37ecea608eb82e60e8badaae398dbf312f3e1f33"} 08:56:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:56:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:56:08 INFO - Contents: 08:56:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d18174b27f9f4e2095c7820639f8d6464719212f7b11c694414b02e0d2bf14f63f77d5861947326289725bfe4207a9b75b558d9e05f0c07eb44838963a2e637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab3ed3045290995fbb8e2320e0beecf60328f78d2de06443140b2d34cb1c8cd6170c5a9add876edc5de2009b37ecea608eb82e60e8badaae398dbf312f3e1f33"} 08:56:08 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:08 INFO - Copying logs to upload dir... 08:56:08 INFO - mkdir: /builds/slave/test/build/upload/logs 08:56:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.905489 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-07 08:56:08.095443) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 08:56:08.099119) ========= 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=aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095 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/2d18174b27f9f4e2095c7820639f8d6464719212f7b11c694414b02e0d2bf14f63f77d5861947326289725bfe4207a9b75b558d9e05f0c07eb44838963a2e637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab3ed3045290995fbb8e2320e0beecf60328f78d2de06443140b2d34cb1c8cd6170c5a9add876edc5de2009b37ecea608eb82e60e8badaae398dbf312f3e1f33"} build_url:https://queue.taskcluster.net/v1/task/e0fGofpyTzarzL2-yxGYJA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/e0fGofpyTzarzL2-yxGYJA/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/2d18174b27f9f4e2095c7820639f8d6464719212f7b11c694414b02e0d2bf14f63f77d5861947326289725bfe4207a9b75b558d9e05f0c07eb44838963a2e637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab3ed3045290995fbb8e2320e0beecf60328f78d2de06443140b2d34cb1c8cd6170c5a9add876edc5de2009b37ecea608eb82e60e8badaae398dbf312f3e1f33"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 08:56:08.123639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:56:08.123975) ========= 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=aa52b8aba932b19cc50b5275000001de-1457368531.315288-269505095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 08:56:08.207517) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 08:56:08.207859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 08:56:08.208158) ========= ========= Total master_lag: 0.28 =========