builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1459858592.0 results: success (0) buildid: 20160404032320 builduid: b2e60f1860704f5c936d50cd634994bd revision: 6fc436f9db859d961581a5f27bbb69731679f593 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.000156) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.000665) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.001003) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006305 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.028132) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.029147) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.042781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.043095) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.094386) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.094738) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.095226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.095619) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 05:16: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-04-05 05:16:32 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.215469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.215850) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022401 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.267671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.268164) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6fc436f9db859d961581a5f27bbb69731679f593 --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 6fc436f9db859d961581a5f27bbb69731679f593 --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=82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 05:16:32,955 truncating revision to first 12 chars 2016-04-05 05:16:32,955 Setting DEBUG logging. 2016-04-05 05:16:32,955 attempt 1/10 2016-04-05 05:16:32,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6fc436f9db85?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 05:16:33,280 unpacking tar archive at: fx-team-6fc436f9db85/testing/mozharness/ program finished with exit code 0 elapsedTime=0.608932 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.895262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.896196) ========= echo 6fc436f9db859d961581a5f27bbb69731679f593 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6fc436f9db859d961581a5f27bbb69731679f593'] 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=82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6fc436f9db859d961581a5f27bbb69731679f593 program finished with exit code 0 elapsedTime=0.004762 script_repo_revision: '6fc436f9db859d961581a5f27bbb69731679f593' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.952852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.953539) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 05:16:32.964882) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-05 05:16:32.965214) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:16:33 INFO - MultiFileLogger online at 20160405 05:16:33 in /builds/slave/test 05:16: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 05:16:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:33 INFO - {'append_to_log': False, 05:16:33 INFO - 'base_work_dir': '/builds/slave/test', 05:16:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:16:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:33 INFO - 'branch': 'Fx-Team-Non-PGO', 05:16:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:33 INFO - 'config_files': ('talos/linux_config.py',), 05:16:33 INFO - 'default_actions': ('clobber', 05:16:33 INFO - 'read-buildbot-config', 05:16:33 INFO - 'download-and-extract', 05:16:33 INFO - 'populate-webroot', 05:16:33 INFO - 'create-virtualenv', 05:16:33 INFO - 'install', 05:16:33 INFO - 'run-tests'), 05:16:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:33 INFO - 'download_minidump_stackwalk': True, 05:16:33 INFO - 'download_symbols': 'ondemand', 05:16:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:33 INFO - 'installer_path': 'installer.exe', 05:16:33 INFO - 'log_level': 'info', 05:16:33 INFO - 'log_name': 'talos', 05:16:33 INFO - 'log_to_console': True, 05:16:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:16:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:16:33 INFO - 'opt_config_files': (), 05:16:33 INFO - 'pip_index': False, 05:16:33 INFO - 'sps_profile': False, 05:16:33 INFO - 'sps_profile_interval': 0, 05:16:33 INFO - 'suite': 'dromaeojs', 05:16:33 INFO - 'system_bits': '32', 05:16:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:33 INFO - 'title': 'talos-linux64-ix-066', 05:16:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:33 INFO - 'use_talos_json': True, 05:16:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:33 INFO - 'work_dir': 'build'} 05:16:33 INFO - ##### 05:16:33 INFO - ##### Running clobber step. 05:16:33 INFO - ##### 05:16:33 INFO - Running pre-action listener: _resource_record_pre_action 05:16:33 INFO - Running main action method: clobber 05:16:33 INFO - rmtree: /builds/slave/test/build 05:16:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:34 INFO - Running post-action listener: _resource_record_post_action 05:16:34 INFO - ##### 05:16:34 INFO - ##### Running read-buildbot-config step. 05:16:34 INFO - ##### 05:16:34 INFO - Running pre-action listener: _resource_record_pre_action 05:16:34 INFO - Running main action method: read_buildbot_config 05:16:34 INFO - Using buildbot properties: 05:16:34 INFO - { 05:16:34 INFO - "project": "", 05:16:34 INFO - "product": "firefox", 05:16:34 INFO - "script_repo_revision": "production", 05:16:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:16:34 INFO - "repository": "", 05:16:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:16:34 INFO - "buildid": "20160404032320", 05:16:34 INFO - "pgo_build": "False", 05:16:34 INFO - "basedir": "/builds/slave/test", 05:16:34 INFO - "buildnumber": 2759, 05:16:34 INFO - "slavename": "talos-linux64-ix-066", 05:16:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:16:34 INFO - "platform": "ubuntu64_hw", 05:16:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:16:34 INFO - "branch": "fx-team", 05:16:34 INFO - "repo_path": "integration/fx-team", 05:16:34 INFO - "revision": "6fc436f9db859d961581a5f27bbb69731679f593", 05:16:34 INFO - "stage_platform": "linux64", 05:16:34 INFO - "builduid": "b2e60f1860704f5c936d50cd634994bd", 05:16:34 INFO - "slavebuilddir": "test" 05:16:34 INFO - } 05:16:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:16:34 INFO - Running post-action listener: _resource_record_post_action 05:16:34 INFO - ##### 05:16:34 INFO - ##### Running download-and-extract step. 05:16:34 INFO - ##### 05:16:34 INFO - Running pre-action listener: _resource_record_pre_action 05:16:34 INFO - Running main action method: download_and_extract 05:16:34 INFO - mkdir: /builds/slave/test/build/tests 05:16: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')]} 05:16:34 INFO - https://queue.taskcluster.net/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:16:34 INFO - Downloaded 1361 bytes. 05:16:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:16:34 INFO - Using the following test package requirements: 05:16:34 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:16:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:16:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:34 INFO - u'jsshell-linux-x86_64.zip'], 05:16:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:16:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:16:34 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:16:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:16:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:16:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:16: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')]} 05:16:34 INFO - https://queue.taskcluster.net/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:36 INFO - Downloaded 22125225 bytes. 05:16:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:16:37 INFO - Return code: 0 05:16:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:16: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')]} 05:16:37 INFO - https://queue.taskcluster.net/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:16:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:38 INFO - Downloaded 22125225 bytes. 05:16:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:16:39 INFO - Return code: 0 05:16:39 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')]} 05:16:39 INFO - https://queue.taskcluster.net/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:16:40 INFO - Downloaded 10847584 bytes. 05:16:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:16:41 INFO - Return code: 0 05:16: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')]} 05:16:41 INFO - https://queue.taskcluster.net/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:16:42 INFO - Downloaded 54089187 bytes. 05:16:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:42 INFO - mkdir: /builds/slave/test/properties 05:16:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:42 INFO - Contents: 05:16:42 INFO - build_url:https://queue.taskcluster.net/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:16:43 INFO - Running post-action listener: _resource_record_post_action 05:16:43 INFO - Running post-action listener: set_extra_try_arguments 05:16:43 INFO - ##### 05:16:43 INFO - ##### Running populate-webroot step. 05:16:43 INFO - ##### 05:16:43 INFO - Running pre-action listener: _resource_record_pre_action 05:16:43 INFO - Running main action method: populate_webroot 05:16:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:43 INFO - '--tppagecycles', 05:16:43 INFO - '7'], 05:16:43 INFO - 'tests': ['tsvgm']}}, 05:16:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:16:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:16:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'tests': ['damp', 'tps']}, 05:16:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['damp', 'tps']}, 05:16:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:16:43 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['dromaeo_dom']}, 05:16:43 INFO - 'other': {'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'other_l64': {'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'other_nol64': {'tests': ['a11yr', 05:16:43 INFO - 'ts_paint', 05:16:43 INFO - 'tpaint', 05:16:43 INFO - 'sessionrestore', 05:16:43 INFO - 'sessionrestore_no_auto_restore', 05:16:43 INFO - 'tabpaint']}, 05:16:43 INFO - 'svgr': {'tests': ['tsvgx', 05:16:43 INFO - 'tsvgr_opacity', 05:16:43 INFO - 'tart', 05:16:43 INFO - 'tscrollx', 05:16:43 INFO - 'cart']}, 05:16:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['tsvgx', 05:16:43 INFO - 'tsvgr_opacity', 05:16:43 INFO - 'tart', 05:16:43 INFO - 'tscrollx', 05:16:43 INFO - 'cart']}, 05:16:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'tests': ['tp5o']}, 05:16:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'talos_options': ['--e10s'], 05:16:43 INFO - 'tests': ['tp5o']}, 05:16:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'talos_options': ['--xperf_path', 05:16:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:43 INFO - 'tests': ['tp5n']}, 05:16:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:43 INFO - 'talos_options': ['--e10s', 05:16:43 INFO - '--xperf_path', 05:16:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:43 INFO - 'tests': ['tp5n']}}, 05:16:43 INFO - 'talos.zip': {'path': '', 05:16:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:43 INFO - Running post-action listener: _resource_record_post_action 05:16:43 INFO - ##### 05:16:43 INFO - ##### Running create-virtualenv step. 05:16:43 INFO - ##### 05:16:43 INFO - Running pre-action listener: _resource_record_pre_action 05:16:43 INFO - Running main action method: create_virtualenv 05:16:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16: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 05:16:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:43 INFO - Using real prefix '/usr' 05:16:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:45 INFO - Installing pip.................done. 05:16:45 INFO - Return code: 0 05:16:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:45 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')]} 05:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:45 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')]} 05:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:45 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 0x7f040ed55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d410>, '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 0x265e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', '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 05:16:45 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 05:16:45 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 05:16:45 INFO - Using env: {'DISPLAY': ':0', 05:16:45 INFO - 'HOME': '/home/cltbld', 05:16:45 INFO - 'LANG': 'en_US.UTF-8', 05:16:45 INFO - 'LANGUAGE': 'en_US:en', 05:16:45 INFO - 'LOGNAME': 'cltbld', 05:16:45 INFO - 'MAIL': '/var/mail/cltbld', 05:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:45 INFO - 'MOZ_NO_REMOTE': '1', 05:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:45 INFO - 'NO_EM_RESTART': '1', 05:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:45 INFO - 'PWD': '/builds/slave/test', 05:16:45 INFO - 'SHELL': '/bin/bash', 05:16:45 INFO - 'SHLVL': '1', 05:16:45 INFO - 'TERM': 'linux', 05:16:45 INFO - 'TMOUT': '86400', 05:16:45 INFO - 'USER': 'cltbld', 05:16:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', 05:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:45 INFO - '_': '/tools/buildbot/bin/python'} 05:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16: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 05:16:46 INFO - Cleaning up... 05:16:46 INFO - Return code: 0 05:16:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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 0x7f040ed55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d410>, '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 0x265e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', '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 05:16: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 05:16: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 05:16:46 INFO - Using env: {'DISPLAY': ':0', 05:16:46 INFO - 'HOME': '/home/cltbld', 05:16:46 INFO - 'LANG': 'en_US.UTF-8', 05:16:46 INFO - 'LANGUAGE': 'en_US:en', 05:16:46 INFO - 'LOGNAME': 'cltbld', 05:16:46 INFO - 'MAIL': '/var/mail/cltbld', 05:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:46 INFO - 'MOZ_NO_REMOTE': '1', 05:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:46 INFO - 'NO_EM_RESTART': '1', 05:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:46 INFO - 'PWD': '/builds/slave/test', 05:16:46 INFO - 'SHELL': '/bin/bash', 05:16:46 INFO - 'SHLVL': '1', 05:16:46 INFO - 'TERM': 'linux', 05:16:46 INFO - 'TMOUT': '86400', 05:16:46 INFO - 'USER': 'cltbld', 05:16:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', 05:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:46 INFO - '_': '/tools/buildbot/bin/python'} 05:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:46 INFO - Downloading/unpacking psutil>=0.7.1 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:48 INFO - Installing collected packages: psutil 05:16:48 INFO - Running setup.py install for psutil 05:16:48 INFO - building 'psutil._psutil_linux' extension 05:16: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 05:16: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 05:16:48 INFO - building 'psutil._psutil_posix' extension 05:16: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 05:16: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:16:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:48 INFO - Successfully installed psutil 05:16:48 INFO - Cleaning up... 05:16:48 INFO - Return code: 0 05:16:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:16:48 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')]} 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 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')]} 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:48 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 0x7f040ed55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d410>, '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 0x265e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', '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 05:16:48 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 05:16:48 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 05:16:48 INFO - Using env: {'DISPLAY': ':0', 05:16:48 INFO - 'HOME': '/home/cltbld', 05:16:48 INFO - 'LANG': 'en_US.UTF-8', 05:16:48 INFO - 'LANGUAGE': 'en_US:en', 05:16:48 INFO - 'LOGNAME': 'cltbld', 05:16:48 INFO - 'MAIL': '/var/mail/cltbld', 05:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:48 INFO - 'MOZ_NO_REMOTE': '1', 05:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:48 INFO - 'NO_EM_RESTART': '1', 05:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:48 INFO - 'PWD': '/builds/slave/test', 05:16:48 INFO - 'SHELL': '/bin/bash', 05:16:48 INFO - 'SHLVL': '1', 05:16:48 INFO - 'TERM': 'linux', 05:16:48 INFO - 'TMOUT': '86400', 05:16:48 INFO - 'USER': 'cltbld', 05:16:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', 05:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:48 INFO - '_': '/tools/buildbot/bin/python'} 05:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:16:50 INFO - Installing collected packages: mozsystemmonitor 05:16:50 INFO - Running setup.py install for mozsystemmonitor 05:16:50 INFO - Successfully installed mozsystemmonitor 05:16:50 INFO - Cleaning up... 05:16:51 INFO - Return code: 0 05:16:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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 0x7f040ed55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d410>, '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 0x265e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', '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 05:16: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 05:16: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 05:16:51 INFO - Using env: {'DISPLAY': ':0', 05:16:51 INFO - 'HOME': '/home/cltbld', 05:16:51 INFO - 'LANG': 'en_US.UTF-8', 05:16:51 INFO - 'LANGUAGE': 'en_US:en', 05:16:51 INFO - 'LOGNAME': 'cltbld', 05:16:51 INFO - 'MAIL': '/var/mail/cltbld', 05:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:51 INFO - 'MOZ_NO_REMOTE': '1', 05:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:51 INFO - 'NO_EM_RESTART': '1', 05:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:51 INFO - 'PWD': '/builds/slave/test', 05:16:51 INFO - 'SHELL': '/bin/bash', 05:16:51 INFO - 'SHLVL': '1', 05:16:51 INFO - 'TERM': 'linux', 05:16:51 INFO - 'TMOUT': '86400', 05:16:51 INFO - 'USER': 'cltbld', 05:16:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', 05:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:51 INFO - '_': '/tools/buildbot/bin/python'} 05:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:51 INFO - Downloading/unpacking blobuploader==1.2.4 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:53 INFO - Downloading docopt-0.6.1.tar.gz 05:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:53 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:53 INFO - Running setup.py install for blobuploader 05:16:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:53 INFO - Running setup.py install for requests 05:16:54 INFO - Running setup.py install for docopt 05:16:54 INFO - Successfully installed blobuploader requests docopt 05:16:54 INFO - Cleaning up... 05:16:54 INFO - Return code: 0 05:16:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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 0x7f040ed55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d410>, '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 0x265e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', '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 05:16: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 05:16: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 05:16:54 INFO - Using env: {'DISPLAY': ':0', 05:16:54 INFO - 'HOME': '/home/cltbld', 05:16:54 INFO - 'LANG': 'en_US.UTF-8', 05:16:54 INFO - 'LANGUAGE': 'en_US:en', 05:16:54 INFO - 'LOGNAME': 'cltbld', 05:16:54 INFO - 'MAIL': '/var/mail/cltbld', 05:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:54 INFO - 'MOZ_NO_REMOTE': '1', 05:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:54 INFO - 'NO_EM_RESTART': '1', 05:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:54 INFO - 'PWD': '/builds/slave/test', 05:16:54 INFO - 'SHELL': '/bin/bash', 05:16:54 INFO - 'SHLVL': '1', 05:16:54 INFO - 'TERM': 'linux', 05:16:54 INFO - 'TMOUT': '86400', 05:16:54 INFO - 'USER': 'cltbld', 05:16:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', 05:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:54 INFO - '_': '/tools/buildbot/bin/python'} 05:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:54 INFO - Running setup.py (path:/tmp/pip-qb2IsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:54 INFO - Running setup.py (path:/tmp/pip-4Gl9iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:54 INFO - Running setup.py (path:/tmp/pip-uHH2kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:54 INFO - Running setup.py (path:/tmp/pip-koSN2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:54 INFO - Running setup.py (path:/tmp/pip-4NrWcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:55 INFO - Running setup.py (path:/tmp/pip-yl8qhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:55 INFO - Running setup.py (path:/tmp/pip-8bHDRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:55 INFO - Running setup.py (path:/tmp/pip-PPIQah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:55 INFO - Running setup.py (path:/tmp/pip-OLbmci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:55 INFO - Running setup.py (path:/tmp/pip-eHNR1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:55 INFO - Running setup.py (path:/tmp/pip-RI12Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:55 INFO - Running setup.py (path:/tmp/pip-nhhmol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:55 INFO - Running setup.py (path:/tmp/pip-URshZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:55 INFO - Running setup.py (path:/tmp/pip-D8QFi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:55 INFO - Running setup.py (path:/tmp/pip-mjYq9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:55 INFO - Running setup.py (path:/tmp/pip-qvJGWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:55 INFO - Running setup.py (path:/tmp/pip-jkkekH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:55 INFO - Running setup.py install for manifestparser 05:16:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Running setup.py install for mozcrash 05:16:56 INFO - Running setup.py install for mozdebug 05:16:56 INFO - Running setup.py install for mozdevice 05:16:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Running setup.py install for mozfile 05:16:56 INFO - Running setup.py install for mozhttpd 05:16:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Running setup.py install for mozinfo 05:16:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Running setup.py install for mozInstall 05:16:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Running setup.py install for mozleak 05:16:56 INFO - Running setup.py install for mozlog 05:16:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:56 INFO - Running setup.py install for moznetwork 05:16:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozprocess 05:16:57 INFO - Running setup.py install for mozprofile 05:16:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozrunner 05:16:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Running setup.py install for mozscreenshot 05:16:57 INFO - Running setup.py install for moztest 05:16:57 INFO - Running setup.py install for mozversion 05:16:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:57 INFO - Cleaning up... 05:16:57 INFO - Return code: 0 05:16:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:57 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 0x7f040ed55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d410>, '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 0x265e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', '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 05:16:57 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 05:16:57 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 05:16:57 INFO - Using env: {'DISPLAY': ':0', 05:16:57 INFO - 'HOME': '/home/cltbld', 05:16:57 INFO - 'LANG': 'en_US.UTF-8', 05:16:57 INFO - 'LANGUAGE': 'en_US:en', 05:16:57 INFO - 'LOGNAME': 'cltbld', 05:16:57 INFO - 'MAIL': '/var/mail/cltbld', 05:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:57 INFO - 'MOZ_NO_REMOTE': '1', 05:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:57 INFO - 'NO_EM_RESTART': '1', 05:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:57 INFO - 'PWD': '/builds/slave/test', 05:16:57 INFO - 'SHELL': '/bin/bash', 05:16:57 INFO - 'SHLVL': '1', 05:16:57 INFO - 'TERM': 'linux', 05:16:57 INFO - 'TMOUT': '86400', 05:16:57 INFO - 'USER': 'cltbld', 05:16:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', 05:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:57 INFO - '_': '/tools/buildbot/bin/python'} 05:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:57 INFO - Running setup.py (path:/tmp/pip-XL5gK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:57 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)) 05:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:57 INFO - Running setup.py (path:/tmp/pip-HkDd9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16: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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:58 INFO - Running setup.py (path:/tmp/pip-Q6yxYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16: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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:58 INFO - Running setup.py (path:/tmp/pip-pwzawY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16: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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:58 INFO - Running setup.py (path:/tmp/pip-WR8Dxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16: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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:58 INFO - Running setup.py (path:/tmp/pip-sGYsl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16: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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:58 INFO - Running setup.py (path:/tmp/pip-SMWwA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16: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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:58 INFO - Running setup.py (path:/tmp/pip-djJfu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16: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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:58 INFO - Running setup.py (path:/tmp/pip-K2zI6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16: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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:58 INFO - Running setup.py (path:/tmp/pip-pVcp4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16: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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:58 INFO - Running setup.py (path:/tmp/pip-YBVkiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:58 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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:58 INFO - Running setup.py (path:/tmp/pip-Gwq66O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:58 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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:58 INFO - Running setup.py (path:/tmp/pip-ZhOpCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:58 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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:58 INFO - Running setup.py (path:/tmp/pip-LOYTJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:58 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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:58 INFO - Running setup.py (path:/tmp/pip-wuNUwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:58 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)) 05:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:58 INFO - Running setup.py (path:/tmp/pip-2vPTr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16: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)) 05:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:59 INFO - Running setup.py (path:/tmp/pip-faI4xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16: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)) 05:16: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)) 05:16: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)) 05:16: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)) 05:16: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)) 05:16: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)) 05:16:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:17:00 INFO - Downloading blessings-1.6.tar.gz 05:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:01 INFO - Installing collected packages: blessings 05:17:01 INFO - Running setup.py install for blessings 05:17:01 INFO - Successfully installed blessings 05:17:01 INFO - Cleaning up... 05:17:01 INFO - Return code: 0 05:17:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:01 INFO - Reading from file tmpfile_stdout 05:17:01 INFO - Current package versions: 05:17:01 INFO - argparse == 1.2.1 05:17:01 INFO - blessings == 1.6 05:17:01 INFO - blobuploader == 1.2.4 05:17:01 INFO - docopt == 0.6.1 05:17:01 INFO - manifestparser == 1.1 05:17:01 INFO - mozInstall == 1.12 05:17:01 INFO - mozcrash == 0.17 05:17:01 INFO - mozdebug == 0.1 05:17:01 INFO - mozdevice == 0.48 05:17:01 INFO - mozfile == 1.2 05:17:01 INFO - mozhttpd == 0.7 05:17:01 INFO - mozinfo == 0.9 05:17:01 INFO - mozleak == 0.1 05:17:01 INFO - mozlog == 3.1 05:17:01 INFO - moznetwork == 0.27 05:17:01 INFO - mozprocess == 0.22 05:17:01 INFO - mozprofile == 0.28 05:17:01 INFO - mozrunner == 6.11 05:17:01 INFO - mozscreenshot == 0.1 05:17:01 INFO - mozsystemmonitor == 0.0 05:17:01 INFO - moztest == 0.7 05:17:01 INFO - mozversion == 1.4 05:17:01 INFO - psutil == 3.1.1 05:17:01 INFO - requests == 1.2.3 05:17:01 INFO - wsgiref == 0.1.2 05:17:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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 0x7f040ed55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d410>, '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 0x265e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', '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 05:17: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 05:17: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 05:17:01 INFO - Using env: {'DISPLAY': ':0', 05:17:01 INFO - 'HOME': '/home/cltbld', 05:17:01 INFO - 'LANG': 'en_US.UTF-8', 05:17:01 INFO - 'LANGUAGE': 'en_US:en', 05:17:01 INFO - 'LOGNAME': 'cltbld', 05:17:01 INFO - 'MAIL': '/var/mail/cltbld', 05:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:01 INFO - 'MOZ_NO_REMOTE': '1', 05:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:01 INFO - 'NO_EM_RESTART': '1', 05:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:01 INFO - 'PWD': '/builds/slave/test', 05:17:01 INFO - 'SHELL': '/bin/bash', 05:17:01 INFO - 'SHLVL': '1', 05:17:01 INFO - 'TERM': 'linux', 05:17:01 INFO - 'TMOUT': '86400', 05:17:01 INFO - 'USER': 'cltbld', 05:17:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', 05:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:01 INFO - '_': '/tools/buildbot/bin/python'} 05:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17: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)) 05:17:01 INFO - Cleaning up... 05:17:01 INFO - Return code: 0 05:17:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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 0x7f040ed55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d410>, '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 0x265e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', '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 05:17: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 05:17: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 05:17:01 INFO - Using env: {'DISPLAY': ':0', 05:17:01 INFO - 'HOME': '/home/cltbld', 05:17:01 INFO - 'LANG': 'en_US.UTF-8', 05:17:01 INFO - 'LANGUAGE': 'en_US:en', 05:17:01 INFO - 'LOGNAME': 'cltbld', 05:17:01 INFO - 'MAIL': '/var/mail/cltbld', 05:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:01 INFO - 'MOZ_NO_REMOTE': '1', 05:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:01 INFO - 'NO_EM_RESTART': '1', 05:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:01 INFO - 'PWD': '/builds/slave/test', 05:17:01 INFO - 'SHELL': '/bin/bash', 05:17:01 INFO - 'SHLVL': '1', 05:17:01 INFO - 'TERM': 'linux', 05:17:01 INFO - 'TMOUT': '86400', 05:17:01 INFO - 'USER': 'cltbld', 05:17:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', 05:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:01 INFO - '_': '/tools/buildbot/bin/python'} 05:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:01 INFO - Downloading/unpacking jsonschema 05:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:03 INFO - Downloading/unpacking functools32 (from jsonschema) 05:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:04 INFO - warning: no files found matching '*.txt' 05:17:04 INFO - no previously-included directories found matching 'build' 05:17:04 INFO - no previously-included directories found matching 'dist' 05:17:04 INFO - no previously-included directories found matching '.git*' 05:17:04 INFO - Installing collected packages: jsonschema, functools32 05:17:04 INFO - Running setup.py install for functools32 05:17:04 INFO - warning: no files found matching '*.txt' 05:17:04 INFO - no previously-included directories found matching 'build' 05:17:04 INFO - no previously-included directories found matching 'dist' 05:17:04 INFO - no previously-included directories found matching '.git*' 05:17:04 INFO - Successfully installed jsonschema functools32 05:17:04 INFO - Cleaning up... 05:17:04 INFO - Return code: 0 05:17:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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 0x7f040ed55f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d410>, '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 0x265e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', '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 05:17: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 05:17: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 05:17:04 INFO - Using env: {'DISPLAY': ':0', 05:17:04 INFO - 'HOME': '/home/cltbld', 05:17:04 INFO - 'LANG': 'en_US.UTF-8', 05:17:04 INFO - 'LANGUAGE': 'en_US:en', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MAIL': '/var/mail/cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SHLVL': '1', 05:17:04 INFO - 'TERM': 'linux', 05:17:04 INFO - 'TMOUT': '86400', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - '_': '/tools/buildbot/bin/python'} 05:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:04 INFO - Downloading/unpacking flake8 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:17:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:17:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:07 INFO - no previously-included directories found matching 'docs/_build' 05:17:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:17:07 INFO - Running setup.py install for pep8 05:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:07 INFO - no previously-included directories found matching 'docs/_build' 05:17:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:17:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:17:07 INFO - Cleaning up... 05:17:07 INFO - Return code: 0 05:17:07 INFO - Running post-action listener: _resource_record_post_action 05:17:07 INFO - Running post-action listener: _start_resource_monitoring 05:17:07 INFO - Starting resource monitoring. 05:17:07 INFO - ##### 05:17:07 INFO - ##### Running install step. 05:17:07 INFO - ##### 05:17:07 INFO - Running pre-action listener: _resource_record_pre_action 05:17:07 INFO - Running main action method: install 05:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:07 INFO - Reading from file tmpfile_stdout 05:17:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:07 INFO - Reading from file tmpfile_stdout 05:17:07 INFO - Output received: 05:17:07 INFO - Usage: mozinstall [options] installer 05:17:07 INFO - Options: 05:17:07 INFO - -h, --help show this help message and exit 05:17:07 INFO - -d DEST, --destination=DEST 05:17:07 INFO - Directory to install application into. [default: 05:17:07 INFO - "/builds/slave/test"] 05:17:07 INFO - --app=APP Application being installed. [default: firefox] 05:17:07 INFO - mkdir: /builds/slave/test/build/application 05:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:17:23 INFO - Reading from file tmpfile_stdout 05:17:23 INFO - Output received: 05:17:23 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:23 INFO - Running post-action listener: _resource_record_post_action 05:17:23 INFO - ##### 05:17:23 INFO - ##### Running run-tests step. 05:17:23 INFO - ##### 05:17:23 INFO - Running pre-action listener: _resource_record_pre_action 05:17:23 INFO - Running main action method: run_tests 05:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:23 INFO - Python 2.7.3 05:17:23 INFO - Return code: 0 05:17:23 INFO - grabbing minidump binary from tooltool 05:17: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')]} 05:17: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 0x265d410>, '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 0x265e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17: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 05:17: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 05:17:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:23 INFO - Return code: 0 05:17:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:17:24 INFO - Return code: 0 05:17: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/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 05:17: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/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 05:17:24 INFO - Using env: {'DISPLAY': ':0', 05:17:24 INFO - 'HOME': '/home/cltbld', 05:17:24 INFO - 'LANG': 'en_US.UTF-8', 05:17:24 INFO - 'LANGUAGE': 'en_US:en', 05:17:24 INFO - 'LOGNAME': 'cltbld', 05:17:24 INFO - 'MAIL': '/var/mail/cltbld', 05:17:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:24 INFO - 'MOZ_NO_REMOTE': '1', 05:17:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:24 INFO - 'NO_EM_RESTART': '1', 05:17:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:24 INFO - 'PWD': '/builds/slave/test', 05:17:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:24 INFO - 'SHELL': '/bin/bash', 05:17:24 INFO - 'SHLVL': '1', 05:17:24 INFO - 'TERM': 'linux', 05:17:24 INFO - 'TMOUT': '86400', 05:17:24 INFO - 'USER': 'cltbld', 05:17:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164', 05:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:24 INFO - '_': '/tools/buildbot/bin/python'} 05:17: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/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 05:17:25 INFO - mozversion application_buildid: 20160404032320 05:17:25 INFO - mozversion application_changeset: 6fc436f9db859d961581a5f27bbb69731679f593 05:17:25 INFO - mozversion application_display_name: Nightly 05:17:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:25 INFO - mozversion application_name: Firefox 05:17:25 INFO - mozversion application_remotingname: firefox 05:17:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:17:25 INFO - mozversion application_vendor: Mozilla 05:17:25 INFO - mozversion application_version: 48.0a1 05:17:25 INFO - mozversion platform_buildid: 20160404032320 05:17:25 INFO - mozversion platform_changeset: 6fc436f9db859d961581a5f27bbb69731679f593 05:17:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:17:25 INFO - mozversion platform_version: 48.0a1 05:17:25 INFO - using testdate: 1459858645 05:17:25 INFO - actual date: 1459858645 05:17:25 INFO - starting webserver on 'localhost:35879' 05:17:25 INFO - SUITE-START | Running 2 tests 05:17:25 INFO - TEST-START | dromaeo_css 05:17:25 INFO - operating with platform_type : linux_ 05:17:25 INFO - Initialising browser for dromaeo_css test... 05:17:25 INFO - TEST-INFO | started process 11304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppT8Qpz/profile http://localhost:35879/getInfo.html) 05:17:29 INFO - PROCESS | 11304 | __metrics Screen width/height:1600/1200 05:17:29 INFO - PROCESS | 11304 | colorDepth:24 05:17:29 INFO - PROCESS | 11304 | Browser inner width/height: 1024/697 05:17:29 INFO - PROCESS | 11304 | __metrics 05:17:30 ERROR - PROCESS | 11304 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:17:31 INFO - TEST-INFO | 11304: exit 0 05:17:31 INFO - Browser initialized. 05:17:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:31 INFO - TEST-INFO | started process 11387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppT8Qpz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:43 INFO - PROCESS | 11387 | RSS: Main: 154955776 05:17:43 INFO - PROCESS | 11387 | 05:18:34 INFO - PROCESS | 11387 | 1459858714803 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] 05:20:46 INFO - PROCESS | 11387 | Cycle 1(1): loaded http://localhost:35879/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35879/tests/dromaeo/cssquery-ext.html) 05:20:47 INFO - PROCESS | 11387 | RSS: Main: 238157824 05:20:47 INFO - PROCESS | 11387 | 05:23:49 INFO - PROCESS | 11387 | Cycle 1(1): loaded http://localhost:35879/tests/dromaeo/cssquery-ext.html (next: http://localhost:35879/tests/dromaeo/cssquery-jquery.html) 05:23:49 INFO - PROCESS | 11387 | RSS: Main: 232861696 05:23:49 INFO - PROCESS | 11387 | 05:26:51 INFO - PROCESS | 11387 | Cycle 1(1): loaded http://localhost:35879/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35879/tests/dromaeo/cssquery-mootools.html) 05:26:52 INFO - PROCESS | 11387 | RSS: Main: 231325696 05:26:52 INFO - PROCESS | 11387 | 05:29:54 INFO - PROCESS | 11387 | Cycle 1(1): loaded http://localhost:35879/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35879/tests/dromaeo/cssquery-prototype.html) 05:29:54 INFO - PROCESS | 11387 | RSS: Main: 196505600 05:29:54 INFO - PROCESS | 11387 | 05:32:57 INFO - PROCESS | 11387 | Cycle 1(1): loaded http://localhost:35879/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35879/tests/dromaeo/cssquery-yui.html) 05:32:58 INFO - PROCESS | 11387 | RSS: Main: 213618688 05:32:58 INFO - PROCESS | 11387 | 05:36:00 INFO - PROCESS | 11387 | Cycle 1(1): loaded http://localhost:35879/tests/dromaeo/cssquery-yui.html (next: http://localhost:35879/tests/dromaeo/cssquery-dojo.html) 05:36:00 INFO - PROCESS | 11387 | RSS: Main: 264077312 05:36:00 INFO - PROCESS | 11387 | 05:36:00 INFO - PROCESS | 11387 | __start_tp_report 05:36:00 INFO - PROCESS | 11387 | _x_x_mozilla_page_load 05:36:00 INFO - PROCESS | 11387 | _x_x_mozilla_page_load_details 05:36:00 INFO - PROCESS | 11387 | |i|pagename|runs| 05:36:00 INFO - PROCESS | 11387 | |0;dojo.html;2580.522603318386;2613.725558816323;2659.3484596273915;2675.906343277986;2690.6098615700716;4476.0824031073635;4540.3870477485525;4548.658850586206;4554.72671639701;4576.1991651460985;4534.56921592449;4568.703034302768;4573.13110509003;4602.8619141425725;4629.213033784256;4167.333226683716;4184.686148538856;4257.233697934371;4280.293751530994;4348.630366418858;4252.0858015526655;4318.892027699301;4326.718763280377;4328.675349348796;4333.393324934496;4102.671786257107;4184;4280.871573852758;4285.914281714379;4295.291276939332;4204.810783514749;4228.5348611653;4243.533211346749;4246.214450326668;4285.292926667096;4215.114825886568;4217.704760666755;4224.936625950613;4246.363045543162;4258.936115958263;4254.191703576311;4363.410939523155;4384.912301753947;4440.511543730187;4477.283634618446;4825.879353016203;4860.854174374775;4865.635077369176;4884.047610715912;4910.165271903785;4760.381150450419;4899.240617704261;4905.460399356068;4916.60667146631;4966.5778408835295;4556.179887620227;4598.172328980749;4600.309953506934;4640.6751527393435;4647.465541462708;4904.337914381585;4922.655414120977;4940.481249468826;4943.777530011158;4960.975195124001;4721;4724.622030237572;4729.834455794031;4742.691725037862;4811.49479304675;4906.460289368167;4925.113479573711;4927.802887884444;4944.258361245842;4972.627052971042;4848.521201033718;4865.197242454955;4875.366202393737;4878.170710979142;4917.754112294442;4675.322078298627;4797.18447863864;4861.683990540603;4895.779689913962;4896.583790377857;4148.875533733993;4158.37624356349;4166.7708276045105;4184.581541845852;4215.114825886537;3593.82030898454;3594.8382322795014;3598.7480876338927;3636.3999940009603;3639.2721455708966;4107.8973025674595;4160.563140870226;4184.100418410057;4222.978885105555;4294.7852607369505;4829.154897892855;4837.129316723023;4841.806327746851;4864.975675121602;4865.878353041202;4180.6446452051305;4180.979095104505;4182.707210495297;4182.996080940613;4219.493660760729;4407.537208593116;4425.114977004612;4455.22033644111;4513.661475389359;4534.523874993079;4621.3068039793625;4625.442930578537;4646.907061858811;4649.093426781745;4702.03608260299;4857.854264372075;4866.221404575251;4873.707577545359;4879.829205977916;4927.113119638356;4553.817847286072;4658.091672123904;4720.834770783006;4732.053589282226;4769;4770.475247722818;4773.952260477351;4788;4797.520247975174;4840.249761287007;4714.528547145258;4803.231482962709;4809.398825146856;4824.758762061953;4878.438979517401;4633.2818413146015;4679.134360143385;4687.531246875285;4714.057188562233;4725.952740472689;4642.350070989996;4670.3228031934495;4672.953270467252;4684.110019096361;4716.528347165256;4506.346579745853;4623.953760462352;4631.652626052992;4633.837815676435;4692.530746925417;4736.076465089274;4758.452777930583;4772.093302272557;4802.711837289634;4802.903941921212;4661.8135274589995;4664.3469914211355;4666.066786642617;4670.9766451167525;4711.034237981137 05:36:00 INFO - PROCESS | 11387 | |1;ext.html;513.2532165698906;528.363322196753;550.54029885046;566.5609152906497;570.9286339207598;27236.319092022684;27714.584281235773;27724;34895.65104348956;35344.646553534454;37857.43213851788;38443.231135377275;38506.80746596263;38514.422283665765;38619.22761544767;7762.107357653871;8046.758597242092;8053.073896501889;8054.395920305971;8058.516489010649;7927.1676473970265;8092.2716955474;8099.109097999215;8111.553864537448;8112.837743245132;8032.3574114071025;8132.959335203315;8139.226773456512;8146.75559733206;8148.144444833296;7995.800104997393;8046.436749427542;8060;8061.113277539466;8079.555624440653;7865.803354916173;7978.840423191504;7979.680812767482;7986.880196797053;8008.959955200245;37829.432558511646;38334.80832595847;38360.616393836266;38382;38400.61599383999;2875.6405449318836;3043.1107354184187;3184.299454120113;3293.5059741038795;3797.1456422305037;28681.086193593266;28814.135575932545;29254.122376328745;29579.556306655417;29849.70150298491;3368.2253081791323;3429.0741499794917;3437.346904088215;3446.483027545863;3621.203335266237;236496;236897;237380;237424.81287593624;237843.99999999828;42660.78669606694;56040;56782.43217567854;56801;56889.14666280009;40264;40446.79776601098;40501.39247911284;40563.39154912678;40612.39081413781;13602.795958060438;13825.308734563432;13825.930870345584;13838.792418113737;13842.723145537235;10739.194560408001;10867.565297388015;10875.51060202277;10877.891221087846;10878.673639790819;14358.138511689333;14382.35279412429;14856.33146508388;14978.176200309088;15045.322960466805;5759.1937128802;5866.354700982888;5884.882302354014;5970.104484327386;5989.670568118708;829.126174844855;879.3448880583878;883.0286684646837;907.8728977943093;996.0537489384968;25978.480430391286;26284;26393;26484.735152648613;26660.60009099865;850.306999795165;941.7268991992382;996.3175224970918;1001.2740762946951;1010.6260683547134;12721.236725796482;12824.679383015498;12946.287954162612;13008.414621341873;13017.47930082805;275946;281731;283083;283107;283918;46679.29981050287;47697;47824;47967;48105;1026.5688410867303;1185.697647099984;1235.1354052163522;1246.059225284886;1269.7523982823445;24616.138435154684;24911.501769964863;25096.498070038862;25129.497410051332;25132.49735005326;34761.65238347584;35073.64926350704;35149.824250878584;35210;35227;166516;167972;168013;168089;168587;27060.864695676395;29610.407791844475;31725.84137079392;32114.03657890267;32207.51688724718;34901.301973960886;35903.820480897426;36290;36319;36702.63297366992;32542.837285814367;33268.833655831564;33476.66523334833;33556.83221583877;34059.82970085134;32501.837490812395;32639.836800815843;32830.67169328276;32847.34305313833;33220.66779332176;32686.83656581702;33032;33348.66651333553;33552.16119597029;33678.66321336755;27422.314442138308;29423.26441838971;29518.55722164212;29586.408271834873;29769.5534566986;23306.417339565967;23493.17773877906;23576.6463503051;23694.407639809142;23727.881360593088 05:36:00 INFO - PROCESS | 11387 | |2;jquery.html;340.7223113162774;343.3476394849785;345.9048761590563;346.6117947898354;356.611293689878;14859.702805943874;15342.309596068177;15965.84034159658;16368.181590920436;16423.17884105793;10295.22785791065;10731.678049658503;10738.463076846147;15934.282957266922;16262.7560586591;4517.661175411833;4645.303204519315;4646.3495110684535;4648.372469716579;4670.252759558472;4452.3544086107495;4592.357070010201;4605.539446055384;4618.35343051973;4633.2586786114225;4602.493725690171;4608.746518941457;4612.377329060568;4619.422572178478;4631.675782695213;4572.359869618256;4636.513166117543;4643.837465688702;4644.767761611923;4647.6281897448125;4524.638028957708;4534.523874993111;4553.658475614342;4558.8632341029825;4560.703554268962;18964.336248231382;19145.425637230765;19517.414477565697;19773.80226197734;19784.406467805988;1811.9852882385774;1867.9252829886789;1969.2123150739676;2136.925207617726;2226;9030.458172509605;9114.635414583408;9362.90637093627;9365.391249568756;9560.28297877655;1716.5622766194665;1726.7496213049037;1763.2543781656195;1776.404904357042;1866.0576408913412;58919.41080589182;60187.69906150485;60293.397066029655;60856.69571652158;61327;9537.14165725088;9562.330636855493;9626.037396260457;9632.325737198329;9776.413415195111;12974.481020759064;13169.67075823093;13207.537736179187;13219.801702974462;13225.338733063309;7135.357817796424;7186.281371862877;7201.747938822116;7332.706691732271;7340.522866013799;6968.965155174293;6976.895346569806;6980.476464265201;7059.8235044123285;7066.046083778727;4108.630223279919;4205.411242426063;4219.1139860629;4255;4258.382534532476;1616.9757453638206;1733.5406117378905;1756.9472915812546;1775.1922875091802;1787.9374221902171;851.438050886412;854.3763052971242;857.6312185760183;866.8309679612541;911.2163539356148;15931.442399516192;15985.920070399574;16117.842389263327;16329.91835040841;16412.425565105164;851.9872201916976;873.5981448533746;880.8546589812737;894.8836651235298;950.011987532958;9149.268058555299;9269.860952085724;9297.907020929839;9372.297077719199;9465.242780577537;379570;388710;391452;396898;399022;67779.3222067773;69042;69337.65331173413;70576.29423705697;70789.6460517694;936.4240991790136;949.050949050949;975.5561219645044;1002.6540843409012;1008.0977525114981;14381.9280903599;14618.780718289021;14644.12135271887;14799.704005920037;14858.479953201586;32753.672463276016;33703;34421.139471513416;34624.134396640286;34679.65320346764;41697;43043.13913721771;43646;46866;47630;6955.443564514928;7073.257307982588;7086.716531338689;7171.569705817667;7222.96388518054;7808.180141085331;10600.04599586041;10975.670729878117;10995.725106872393;11048.558057677603;9548.331616786758;9693.176080032994;9698.418094914328;9772.364796288219;9937;9325.673601423918;9883.654072107442;9975.45135017581;10031.598736050477;10411.271211015157;10319.638812641522;10340.172786177238;10424.270301078852;10512.31669941482;10518;7133.536320139382;7194.604296763729;7330.5968171751065;7395.963020184865;7793.10379306387;10124;10258;10338.328008679411;10398.324108932895;10494.842577361193 05:36:00 INFO - PROCESS | 11387 | |3;mootools.html;1172.5485688010112;1379.8551152129025;1392.4778208171936;1536.6158460384904;1737.2095696458105;7021.648917554121;7162.212156662763;7176.174739904913;7196.280371962801;7205.531640443374;7066.681999310031;7183.497155199138;7201.2438693937165;7207.243239459846;7223.56658600483;1837.7978422373528;1878.4458584717472;2171.207509259125;2200.119952019193;2220.9000594973263;2227.888605569723;2233.9888300558473;2238.3061251012236;2240.5854916840353;2241.708577884881;2177.68423578581;2213.8339624528144;2239.3505883293824;2239.540894116702;2252.8986195621237;2185.0604240176717;2224.2993457061057;2227.3763346263154;2227.7883601057874;2243.809276211524;2172.0117346607412;2186.9343919682433;2202.2952655150198;2204.0963205085836;2206.8344874134345;7312.963435182844;7331.0469638947125;7344.926550734478;7361.043064401647;7367.852642947111;4477.708948918343;4596.931046034312;4598.977005114986;4621.884452888671;4638.350630911675;2861.828290302568;2869.956950645742;2902.782291328159;2905.142982820052;3014.668386477486;936.9063093690645;965.9275554333453;968.1963969904962;979.911807937282;992.4591097851616;9893.752656183653;9919.156871665917;9921.851172232422;9976.551055202533;9977.351472154287;3995.9200815983518;4063.79681015948;4098.139390727921;4116.794160291974;4133.81397837098;8532.104129066483;8565.571721413904;8602.18279263469;8605.225529702357;8606.741797746077;4585.082983403333;4597.7241365518175;4598.586127248564;4600.4479462464715;4603.263477843529;3470.6529347065093;3986.262541429787;4119.114390406077;4119.134981653826;4121.855735049259;3413.4367829307885;3487.6512348764923;3488.54648895647;3499.5100685903994;3536.8054756988613;1134.7276653603242;1140.1505878120854;1140.156284349592;1150.3615493401242;1152.1243854670342;1192.66605350502;1196.1029228078942;1197.3534291482677;1197.467127128437;1211.4790640024873;6555;6690.899636505456;6725.024871393621;6745.190577130776;6751.729930802811;458.24389756901377;469.2117243031739;473.1506945033604;473.44843257604504;478.1345764166869;5067.797288108434;5074.08666440037;5086.465921078234;5095.643304968691;5119.539241468286;8517.829643407222;8607.18231767981;8881.866771998426;8887.822243555092;8966.775830604287;8867.290616750644;8885.955570222108;8954.820903581893;8963.596638151299;8997.190252877272;6620.8344791380605;6774.695138718769;6849.1438570178725;7013.473989450812;7017.543859649107;6687.030380594883;6735.259121496533;6738.932610673831;6738.966305168443;6770.1537307836525;7830.804229894298;7893.17121702236;8134.75595732129;8270.297024752723;8276.875846862182;7633.6564854580565;7841.333486653698;7851.254130857559;7859.214078592324;8401.579921004048;5724.284464441945;6119.724612392364;6288.591241569284;6324.272708638381;6381;6900.3444672756;6950.235474097946;6973.023776671169;6987.9301206987275;6996.300369962963;6111.663858487826;6269.937300626935;6283.3088360281245;6283.8114856554375;6294.402031806971;6206.565540412308;6253.937460625336;6287.74849006053;6363.045543168377;6374.776882809079;6419.422251997343;6445.806625801233;6460.903086453801;6472.126262954441;6478.708458119301;6135.049067394561;6143.262808463013;6219.720112594853;6223.533235007302;6224.284207316216;6187.133801267916;6207;6217.906731399123;6251.562390632612;6270.874582508415 05:36:00 INFO - PROCESS | 11387 | |4;prototype.html;286.71185458614104;294.64053854297754;299.1891972753837;303.10281566562986;308.11724409566597;5188.299579556769;5252.50101240382;5263.631545791796;5280.049591073605;5285.577153827694;5178.378594568648;5191.922121168176;5204.479552044793;5231.869203269911;5235.450277720842;3886.8833934981994;4002.1995600879795;4099.159672267193;4100.753954762717;4120.732152410099;4112.773797441139;4114.7119701620895;4121.031557583965;4123.711340206187;4126.174765046988;4078.775667338295;4091.9181616367655;4095.877123686294;4096.406021126935;4098.036961314089;3880.301545721769;3944.8619298324707;4005.339119045354;4018.799060046986;4035.515738111416;3583.820808959568;3584.211473475857;3587.9820600897087;3588.802615856127;3596.6403359664087;4982.725950072744;4983.8504844854715;4994.625403094746;4995.300657907896;5001.099802035668;4662.440507139131;4667.579917807414;4669.066186762661;4674.135284972291;4678.8596342109795;5461.69960652164;5466.371367292772;5470.370907345667;5473.9452605474235;5474.507294343528;3926.6269704378037;3926.8232929517953;3927.430522574211;3929.764214147132;3948.1511475033008;5511.807086751985;5691.800786972436;5698.259226300595;5702.116171993348;5704.914426283568;3976.2842688315804;4008.7394319369146;4011.6991225658194;4022.758634481882;4025.0742329264435;4071.307877660805;4073.2668119738137;4073.307537718595;4073.837046518106;4087.141700242982;4614.538546145359;4618.56123668251;4626.398568186114;4626.976865115653;4631.8378856739855;5471.042567550663;5472.91790623141;5475.972620136953;5482.342118945752;5482.862928426742;1410.7319609274205;1447.6091455307007;1452.491627930216;1455.5196785060905;1459.3505889879114;873.3929918706565;907.4827348411474;914.8719179314901;957.5643082397493;977.6822532676766;4801.4718380978065;4822.831200908022;4833.709977401367;4839.733814640229;4847.733374664427;5631.831045068655;5640.492355688008;5644.181593668895;5650.689212093293;5684.09054551278;4805.879853003703;4827.034593081397;4832.540908613746;4835.323054772335;4837.911469919311;3024.168353702705;3055.236190952262;3056.1595561220397;3061.770367222467;3065.5401689746272;5377.892442151135;5399.865003374947;5414.593905457028;5422.240886275925;5424.077906755782;5631.8592035199445;5813.186153938452;5815.505682016991;5816.185733997244;5822.184894114827;5379.569634429236;5389.649672771257;5392.487713667196;5399.541039011728;5408;5655.7454914528125;5656;5656.264685591012;5664.943350566442;5666.490015898589;5506.146547285177;5537.307836520435;5544.306961629796;5549.112142057252;5563.666180029211;5382.246485491956;5396.406395296436;5405.756740946588;5405.945940540544;5412.323459567554;3738.8130593469673;3819.1788765415567;3858.0740622249896;3867.7679339239735;3881.8835434936996;5442.346918369821;5569.888602228014;5601.29983752031;5636.098224284095;5650;5482.616216864941;5492.258545096521;5498.945010550004;5533.5849811263515;5559.916601250903;5269.104252277046;5370.704611246263;5492.313460817398;5499.202615620633;5500.449955004628;5395.595330350161;5404.243405923095;5426.593005524523;5470.288862447856;5480.506754392124;5567.832965011056;5569.916451253315;5579;5582.16267559853;5587.413321601173;5403.756830942696;5434;5446.183072539151;5447.591430642638;5448.564114870722 05:36:00 INFO - PROCESS | 11387 | |5;yui.html;600.128528350388;620.6307247187922;741.7700512841017;753.491393309516;770.3644493293035;11812.409379531022;11925.940370298158;11964.760704785898;11971.341576213315;12006.219595726272;11356.659300220987;11359.943200284008;11369.602063927765;11390.829137562923;11442.7139321517;621.692262330146;785.308928143236;799.220759759233;810.2464707821723;810.4934415990007;799.2367289238763;800.5476905548376;805.375833728859;805.9274665280124;807.8747794091926;657.697459168783;829.4525613095358;831.9417640765149;832.5545832979358;835.0939230934413;823.4935514658472;836.6318819719304;838.8028813228948;839.0812060793452;839.1398816213369;615.4983688294026;617.4227097663654;618.6999305336954;619.3899009475663;619.7304172684896;12424.627261182179;12528;12548.937255313756;12571.245725256422;12576.434060467302;11363.318200907972;11556.53773849045;11798.233114847508;11942;12183.51265949361;8611.224989750952;8650.351223658188;8674.522901240429;8765.167309105625;8910.242629376446;3318.6847249511256;3324.1024923270825;3351.0449521886144;3352.0614228016193;3417.79493230407;42633.78683106565;42833.35749963753;42865.57134428647;42921;42950.78524607388;9179.357444978787;9546;9575.180715664;9677.274204434696;9686.418814871131;17382.91308543449;17431;17445.825541744674;17457.21442535089;17476.825231747775;6512.34876512345;6632.602043877383;6657.635184787107;6730.764423245163;6735.057092007123;3650.142216579102;3656.74402791802;3660.432632941898;3666.4683620874825;3719.8512059517316;2732.9316767080586;2740.725927407283;2753.435545713124;2757.696653368128;2761.1854502921688;501.94729553396365;538.7737150396842;543.4511143744846;544.0750723769607;549.4395716369361;494.695762106302;532.3718012744921;538.9110796718497;558.0318148013193;575.6776205325032;7490.288422599844;7641;7702.537847729154;7710.730124445618;7718.922810771933;542.782886845265;559.7732918168149;562.2662425534635;564.5850300029475;566.3854717631416;3442.5868895732674;3631.418972964313;3678.797666128335;3698.500702405141;3935.665468435158;47031;49988.250176247384;50061;50091.749541252786;50158.247626285636;44118.33822492665;44339.11321773547;44438.77780611076;44453;44748.3287750684;41325.79337103295;42445;42515.7874210627;42815.14369712588;43009.569904301185;7732.497387669783;7901;7936.882233881594;7980.640871160927;8055.1944805521325;30651.693483064882;31526.842365788023;32651.510227346134;33163.17092072718;33314.66685333213;36959.815200923826;38330.61669383271;40294.59705403026;40600.39099413452;40746.59253407546;9875.20998320147;9889.55497002651;9943.30396872212;9948;9978.101970822661;9852;10611.575536978435;10731.087857532197;10740.087092597218;10787.67636970892;10020.64927727526;10069.244806639384;10357.415739876087;10544.209184311361;10554.947225263824;10009.499525023573;10011.399316041061;10050.145737612385;10110.443925584164;10585.100266477128;9532.142107210384;9602.32783705134;9702.417854928726;9860.950695246478;9892.356996795184;8743.693970711249;8936.731898043068;9053.411528250643;9059.592318345558;9153.405028673114;8832.5583720815;8859.158379953895;8930.732078037669;8944.150305720947;9267.258619310303 05:36:00 INFO - PROCESS | 11387 | __end_tp_report 05:36:00 INFO - PROCESS | 11387 | __start_cc_report 05:36:00 INFO - PROCESS | 11387 | _x_x_mozilla_cycle_collect,851 05:36:00 INFO - PROCESS | 11387 | __end_cc_report 05:36:00 INFO - PROCESS | 11387 | __startTimestamp1459859760841__endTimestamp 05:36:00 INFO - PROCESS | 11387 | 05:36:00 INFO - PROCESS | 11387 | ------- Summary: start ------- 05:36:00 INFO - PROCESS | 11387 | Number of tests: 6 05:36:00 INFO - PROCESS | 11387 | 05:36:00 INFO - PROCESS | 11387 | [#0] dojo.html Cycles:165 Average:4510.09 Median:4642.35 stddev:448.45 (9.7%) stddev-sans-first:423.51 05:36:00 INFO - PROCESS | 11387 | Values: 2580.5 2613.7 2659.3 2675.9 2690.6 4476.1 4540.4 4548.7 4554.7 4576.2 4534.6 4568.7 4573.1 4602.9 4629.2 4167.3 4184.7 4257.2 4280.3 4348.6 4252.1 4318.9 4326.7 4328.7 4333.4 4102.7 4184.0 4280.9 4285.9 4295.3 4204.8 4228.5 4243.5 4246.2 4285.3 4215.1 4217.7 4224.9 4246.4 4258.9 4254.2 4363.4 4384.9 4440.5 4477.3 4825.9 4860.9 4865.6 4884.0 4910.2 4760.4 4899.2 4905.5 4916.6 4966.6 4556.2 4598.2 4600.3 4640.7 4647.5 4904.3 4922.7 4940.5 4943.8 4961.0 4721.0 4724.6 4729.8 4742.7 4811.5 4906.5 4925.1 4927.8 4944.3 4972.6 4848.5 4865.2 4875.4 4878.2 4917.8 4675.3 4797.2 4861.7 4895.8 4896.6 4148.9 4158.4 4166.8 4184.6 4215.1 3593.8 3594.8 3598.7 3636.4 3639.3 4107.9 4160.6 4184.1 4223.0 4294.8 4829.2 4837.1 4841.8 4865.0 4865.9 4180.6 4181.0 4182.7 4183.0 4219.5 4407.5 4425.1 4455.2 4513.7 4534.5 4621.3 4625.4 4646.9 4649.1 4702.0 4857.9 4866.2 4873.7 4879.8 4927.1 4553.8 4658.1 4720.8 4732.1 4769.0 4770.5 4774.0 4788.0 4797.5 4840.2 4714.5 4803.2 4809.4 4824.8 4878.4 4633.3 4679.1 4687.5 4714.1 4726.0 4642.4 4670.3 4673.0 4684.1 4716.5 4506.3 4624.0 4631.7 4633.8 4692.5 4736.1 4758.5 4772.1 4802.7 4802.9 4661.8 4664.3 4666.1 4671.0 4711.0 05:36:00 INFO - PROCESS | 11387 | 05:36:00 INFO - PROCESS | 11387 | [#1] ext.html Cycles:180 Average:38300.75 Median:33554.50 stddev:60963.63 (181.7%) stddev-sans-first:61068.63 05:36:00 INFO - PROCESS | 11387 | Values: 513.3 528.4 550.5 566.6 570.9 27236.3 27714.6 27724.0 34895.7 35344.6 37857.4 38443.2 38506.8 38514.4 38619.2 7762.1 8046.8 8053.1 8054.4 8058.5 7927.2 8092.3 8099.1 8111.6 8112.8 8032.4 8133.0 8139.2 8146.8 8148.1 7995.8 8046.4 8060.0 8061.1 8079.6 7865.8 7978.8 7979.7 7986.9 8009.0 37829.4 38334.8 38360.6 38382.0 38400.6 2875.6 3043.1 3184.3 3293.5 3797.1 28681.1 28814.1 29254.1 29579.6 29849.7 3368.2 3429.1 3437.3 3446.5 3621.2 236496.0 236897.0 237380.0 237424.8 237844.0 42660.8 56040.0 56782.4 56801.0 56889.1 40264.0 40446.8 40501.4 40563.4 40612.4 13602.8 13825.3 13825.9 13838.8 13842.7 10739.2 10867.6 10875.5 10877.9 10878.7 14358.1 14382.4 14856.3 14978.2 15045.3 5759.2 5866.4 5884.9 5970.1 5989.7 829.1 879.3 883.0 907.9 996.1 25978.5 26284.0 26393.0 26484.7 26660.6 850.3 941.7 996.3 1001.3 1010.6 12721.2 12824.7 12946.3 13008.4 13017.5 275946.0 281731.0 283083.0 283107.0 283918.0 46679.3 47697.0 47824.0 47967.0 48105.0 1026.6 1185.7 1235.1 1246.1 1269.8 24616.1 24911.5 25096.5 25129.5 25132.5 34761.7 35073.6 35149.8 35210.0 35227.0 166516.0 167972.0 168013.0 168089.0 168587.0 27060.9 29610.4 31725.8 32114.0 32207.5 34901.3 35903.8 36290.0 36319.0 36702.6 32542.8 33268.8 33476.7 33556.8 34059.8 32501.8 32639.8 32830.7 32847.3 33220.7 32686.8 33032.0 33348.7 33552.2 33678.7 27422.3 29423.3 29518.6 29586.4 29769.6 23306.4 23493.2 23576.6 23694.4 23727.9 05:36:00 INFO - PROCESS | 11387 | 05:36:00 INFO - PROCESS | 11387 | [#2] jquery.html Cycles:180 Average:23194.05 Median:4556.26 stddev:64265.85 (1410.5%) stddev-sans-first:64423.22 05:36:00 INFO - PROCESS | 11387 | Values: 340.7 343.3 345.9 346.6 356.6 14859.7 15342.3 15965.8 16368.2 16423.2 10295.2 10731.7 10738.5 15934.3 16262.8 4517.7 4645.3 4646.3 4648.4 4670.3 4452.4 4592.4 4605.5 4618.4 4633.3 4602.5 4608.7 4612.4 4619.4 4631.7 4572.4 4636.5 4643.8 4644.8 4647.6 4524.6 4534.5 4553.7 4558.9 4560.7 18964.3 19145.4 19517.4 19773.8 19784.4 1812.0 1867.9 1969.2 2136.9 2226.0 9030.5 9114.6 9362.9 9365.4 9560.3 1716.6 1726.7 1763.3 1776.4 1866.1 58919.4 60187.7 60293.4 60856.7 61327.0 9537.1 9562.3 9626.0 9632.3 9776.4 12974.5 13169.7 13207.5 13219.8 13225.3 7135.4 7186.3 7201.7 7332.7 7340.5 6969.0 6976.9 6980.5 7059.8 7066.0 4108.6 4205.4 4219.1 4255.0 4258.4 1617.0 1733.5 1756.9 1775.2 1787.9 851.4 854.4 857.6 866.8 911.2 15931.4 15985.9 16117.8 16329.9 16412.4 852.0 873.6 880.9 894.9 950.0 9149.3 9269.9 9297.9 9372.3 9465.2 379570.0 388710.0 391452.0 396898.0 399022.0 67779.3 69042.0 69337.7 70576.3 70789.6 936.4 949.1 975.6 1002.7 1008.1 14381.9 14618.8 14644.1 14799.7 14858.5 32753.7 33703.0 34421.1 34624.1 34679.7 41697.0 43043.1 43646.0 46866.0 47630.0 6955.4 7073.3 7086.7 7171.6 7223.0 7808.2 10600.0 10975.7 10995.7 11048.6 9548.3 9693.2 9698.4 9772.4 9937.0 9325.7 9883.7 9975.5 10031.6 10411.3 10319.6 10340.2 10424.3 10512.3 10518.0 7133.5 7194.6 7330.6 7396.0 7793.1 10124.0 10258.0 10338.3 10398.3 10494.8 05:36:00 INFO - PROCESS | 11387 | 05:36:00 INFO - PROCESS | 11387 | [#3] mootools.html Cycles:180 Average:5100.12 Median:6223.91 stddev:2641.69 (42.4%) stddev-sans-first:2632.60 05:36:00 INFO - PROCESS | 11387 | Values: 1172.5 1379.9 1392.5 1536.6 1737.2 7021.6 7162.2 7176.2 7196.3 7205.5 7066.7 7183.5 7201.2 7207.2 7223.6 1837.8 1878.4 2171.2 2200.1 2220.9 2227.9 2234.0 2238.3 2240.6 2241.7 2177.7 2213.8 2239.4 2239.5 2252.9 2185.1 2224.3 2227.4 2227.8 2243.8 2172.0 2186.9 2202.3 2204.1 2206.8 7313.0 7331.0 7344.9 7361.0 7367.9 4477.7 4596.9 4599.0 4621.9 4638.4 2861.8 2870.0 2902.8 2905.1 3014.7 936.9 965.9 968.2 979.9 992.5 9893.8 9919.2 9921.9 9976.6 9977.4 3995.9 4063.8 4098.1 4116.8 4133.8 8532.1 8565.6 8602.2 8605.2 8606.7 4585.1 4597.7 4598.6 4600.4 4603.3 3470.7 3986.3 4119.1 4119.1 4121.9 3413.4 3487.7 3488.5 3499.5 3536.8 1134.7 1140.2 1140.2 1150.4 1152.1 1192.7 1196.1 1197.4 1197.5 1211.5 6555.0 6690.9 6725.0 6745.2 6751.7 458.2 469.2 473.2 473.4 478.1 5067.8 5074.1 5086.5 5095.6 5119.5 8517.8 8607.2 8881.9 8887.8 8966.8 8867.3 8886.0 8954.8 8963.6 8997.2 6620.8 6774.7 6849.1 7013.5 7017.5 6687.0 6735.3 6738.9 6739.0 6770.2 7830.8 7893.2 8134.8 8270.3 8276.9 7633.7 7841.3 7851.3 7859.2 8401.6 5724.3 6119.7 6288.6 6324.3 6381.0 6900.3 6950.2 6973.0 6987.9 6996.3 6111.7 6269.9 6283.3 6283.8 6294.4 6206.6 6253.9 6287.7 6363.0 6374.8 6419.4 6445.8 6460.9 6472.1 6478.7 6135.0 6143.3 6219.7 6223.5 6224.3 6187.1 6207.0 6217.9 6251.6 6270.9 05:36:00 INFO - PROCESS | 11387 | 05:36:00 INFO - PROCESS | 11387 | [#4] prototype.html Cycles:180 Average:4561.24 Median:5243.98 stddev:1328.47 (25.3%) stddev-sans-first:1292.87 05:36:00 INFO - PROCESS | 11387 | Values: 286.7 294.6 299.2 303.1 308.1 5188.3 5252.5 5263.6 5280.0 5285.6 5178.4 5191.9 5204.5 5231.9 5235.5 3886.9 4002.2 4099.2 4100.8 4120.7 4112.8 4114.7 4121.0 4123.7 4126.2 4078.8 4091.9 4095.9 4096.4 4098.0 3880.3 3944.9 4005.3 4018.8 4035.5 3583.8 3584.2 3588.0 3588.8 3596.6 4982.7 4983.9 4994.6 4995.3 5001.1 4662.4 4667.6 4669.1 4674.1 4678.9 5461.7 5466.4 5470.4 5473.9 5474.5 3926.6 3926.8 3927.4 3929.8 3948.2 5511.8 5691.8 5698.3 5702.1 5704.9 3976.3 4008.7 4011.7 4022.8 4025.1 4071.3 4073.3 4073.3 4073.8 4087.1 4614.5 4618.6 4626.4 4627.0 4631.8 5471.0 5472.9 5476.0 5482.3 5482.9 1410.7 1447.6 1452.5 1455.5 1459.4 873.4 907.5 914.9 957.6 977.7 4801.5 4822.8 4833.7 4839.7 4847.7 5631.8 5640.5 5644.2 5650.7 5684.1 4805.9 4827.0 4832.5 4835.3 4837.9 3024.2 3055.2 3056.2 3061.8 3065.5 5377.9 5399.9 5414.6 5422.2 5424.1 5631.9 5813.2 5815.5 5816.2 5822.2 5379.6 5389.6 5392.5 5399.5 5408.0 5655.7 5656.0 5656.3 5664.9 5666.5 5506.1 5537.3 5544.3 5549.1 5563.7 5382.2 5396.4 5405.8 5405.9 5412.3 3738.8 3819.2 3858.1 3867.8 3881.9 5442.3 5569.9 5601.3 5636.1 5650.0 5482.6 5492.3 5498.9 5533.6 5559.9 5269.1 5370.7 5492.3 5499.2 5500.4 5395.6 5404.2 5426.6 5470.3 5480.5 5567.8 5569.9 5579.0 5582.2 5587.4 5403.8 5434.0 5446.2 5447.6 5448.6 05:36:00 INFO - PROCESS | 11387 | 05:36:00 INFO - PROCESS | 11387 | [#5] yui.html Cycles:180 Average:12348.53 Median:25345.31 stddev:14075.12 (55.5%) stddev-sans-first:14086.95 05:36:00 INFO - PROCESS | 11387 | Values: 600.1 620.6 741.8 753.5 770.4 11812.4 11925.9 11964.8 11971.3 12006.2 11356.7 11359.9 11369.6 11390.8 11442.7 621.7 785.3 799.2 810.2 810.5 799.2 800.5 805.4 805.9 807.9 657.7 829.5 831.9 832.6 835.1 823.5 836.6 838.8 839.1 839.1 615.5 617.4 618.7 619.4 619.7 12424.6 12528.0 12548.9 12571.2 12576.4 11363.3 11556.5 11798.2 11942.0 12183.5 8611.2 8650.4 8674.5 8765.2 8910.2 3318.7 3324.1 3351.0 3352.1 3417.8 42633.8 42833.4 42865.6 42921.0 42950.8 9179.4 9546.0 9575.2 9677.3 9686.4 17382.9 17431.0 17445.8 17457.2 17476.8 6512.3 6632.6 6657.6 6730.8 6735.1 3650.1 3656.7 3660.4 3666.5 3719.9 2732.9 2740.7 2753.4 2757.7 2761.2 501.9 538.8 543.5 544.1 549.4 494.7 532.4 538.9 558.0 575.7 7490.3 7641.0 7702.5 7710.7 7718.9 542.8 559.8 562.3 564.6 566.4 3442.6 3631.4 3678.8 3698.5 3935.7 47031.0 49988.3 50061.0 50091.7 50158.2 44118.3 44339.1 44438.8 44453.0 44748.3 41325.8 42445.0 42515.8 42815.1 43009.6 7732.5 7901.0 7936.9 7980.6 8055.2 30651.7 31526.8 32651.5 33163.2 33314.7 36959.8 38330.6 40294.6 40600.4 40746.6 9875.2 9889.6 9943.3 9948.0 9978.1 9852.0 10611.6 10731.1 10740.1 10787.7 10020.6 10069.2 10357.4 10544.2 10554.9 10009.5 10011.4 10050.1 10110.4 10585.1 9532.1 9602.3 9702.4 9861.0 9892.4 8743.7 8936.7 9053.4 9059.6 9153.4 8832.6 8859.2 8930.7 8944.2 9267.3 05:36:00 INFO - PROCESS | 11387 | -------- Summary: end -------- 05:36:00 INFO - PROCESS | 11387 | 05:36:01 INFO - TEST-INFO | 11387: exit 0 05:36:01 INFO - TEST-OK | dromaeo_css | took 1116521ms 05:36:01 INFO - TEST-START | kraken 05:36:01 INFO - operating with platform_type : linux_ 05:36:01 INFO - Initialising browser for kraken test... 05:36:01 INFO - TEST-INFO | started process 11564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ8FxaT/profile http://localhost:35879/getInfo.html) 05:36:06 INFO - PROCESS | 11564 | __metrics Screen width/height:1600/1200 05:36:06 INFO - PROCESS | 11564 | colorDepth:24 05:36:06 INFO - PROCESS | 11564 | Browser inner width/height: 1024/697 05:36:06 INFO - PROCESS | 11564 | __metrics 05:36:07 ERROR - PROCESS | 11564 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:36:08 INFO - TEST-INFO | 11564: exit 0 05:36:08 INFO - Browser initialized. 05:36:08 INFO - Running cycle 1/1 for kraken test... 05:36:08 INFO - TEST-INFO | started process 11644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ8FxaT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:20 INFO - PROCESS | 11644 | RSS: Main: 155238400 05:36:20 INFO - PROCESS | 11644 | 05:36:22 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35879/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:23 INFO - PROCESS | 11644 | RSS: Main: 195575808 05:36:23 INFO - PROCESS | 11644 | 05:36:26 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35879/tests/kraken/driver.html?testName=audio-dft) 05:36:26 INFO - PROCESS | 11644 | RSS: Main: 185278464 05:36:26 INFO - PROCESS | 11644 | 05:36:29 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35879/tests/kraken/driver.html?testName=audio-fft) 05:36:30 INFO - PROCESS | 11644 | RSS: Main: 170283008 05:36:30 INFO - PROCESS | 11644 | 05:36:32 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35879/tests/kraken/driver.html?testName=audio-oscillator) 05:36:32 INFO - PROCESS | 11644 | RSS: Main: 173039616 05:36:32 INFO - PROCESS | 11644 | 05:36:35 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35879/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:35 INFO - PROCESS | 11644 | RSS: Main: 174526464 05:36:35 INFO - PROCESS | 11644 | 05:36:38 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35879/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:39 INFO - PROCESS | 11644 | RSS: Main: 174850048 05:36:39 INFO - PROCESS | 11644 | 05:36:42 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35879/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:43 INFO - PROCESS | 11644 | RSS: Main: 175697920 05:36:43 INFO - PROCESS | 11644 | 05:36:46 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35879/tests/kraken/driver.html?testName=json-parse-financial) 05:36:47 INFO - PROCESS | 11644 | RSS: Main: 175259648 05:36:47 INFO - PROCESS | 11644 | 05:36:48 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35879/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:49 INFO - PROCESS | 11644 | RSS: Main: 185184256 05:36:49 INFO - PROCESS | 11644 | 05:36:51 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35879/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:51 INFO - PROCESS | 11644 | RSS: Main: 182960128 05:36:51 INFO - PROCESS | 11644 | 05:36:53 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35879/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:54 INFO - PROCESS | 11644 | RSS: Main: 192827392 05:36:54 INFO - PROCESS | 11644 | 05:36:57 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35879/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:57 INFO - PROCESS | 11644 | RSS: Main: 199847936 05:36:57 INFO - PROCESS | 11644 | 05:37:00 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35879/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:00 INFO - PROCESS | 11644 | RSS: Main: 197128192 05:37:00 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | Cycle 1(1): loaded http://localhost:35879/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35879/tests/kraken/driver.html?testName=ai-astar) 05:37:02 INFO - PROCESS | 11644 | RSS: Main: 258756608 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | __start_tp_report 05:37:02 INFO - PROCESS | 11644 | _x_x_mozilla_page_load 05:37:02 INFO - PROCESS | 11644 | _x_x_mozilla_page_load_details 05:37:02 INFO - PROCESS | 11644 | |i|pagename|runs| 05:37:02 INFO - PROCESS | 11644 | |0;ai-astar;111;112;110;113;113;116;103;113;113;113 05:37:02 INFO - PROCESS | 11644 | |1;audio-beat-detection;164;134;157;181;134;159;161;133;185;136 05:37:02 INFO - PROCESS | 11644 | |2;audio-dft;163;161;162;161;161;161;164;164;162;162 05:37:02 INFO - PROCESS | 11644 | |3;audio-fft;74;75;103;98;73;73;73;114;101;77 05:37:02 INFO - PROCESS | 11644 | |4;audio-oscillator;93;96;146;94;93;94;147;94;94;135 05:37:02 INFO - PROCESS | 11644 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 05:37:02 INFO - PROCESS | 11644 | |6;imaging-darkroom;145;147;146;146;146;145;145;148;146;146 05:37:02 INFO - PROCESS | 11644 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;96;95 05:37:02 INFO - PROCESS | 11644 | |8;json-parse-financial;65;67;73;67;66;66;66;75;62;63 05:37:02 INFO - PROCESS | 11644 | |9;json-stringify-tinderbox;63;63;64;64;64;64;64;63;64;64 05:37:02 INFO - PROCESS | 11644 | |10;stanford-crypto-aes;82;83;84;82;83;82;81;81;89;82 05:37:02 INFO - PROCESS | 11644 | |11;stanford-crypto-ccm;123;122;118;125;119;120;121;121;116;124 05:37:02 INFO - PROCESS | 11644 | |12;stanford-crypto-pbkdf2;134;142;142;140;140;132;139;142;138;141 05:37:02 INFO - PROCESS | 11644 | |13;stanford-crypto-sha256-iterative;67;66;68;68;67;66;68;67;68;66 05:37:02 INFO - PROCESS | 11644 | __end_tp_report 05:37:02 INFO - PROCESS | 11644 | __start_cc_report 05:37:02 INFO - PROCESS | 11644 | _x_x_mozilla_cycle_collect,1190 05:37:02 INFO - PROCESS | 11644 | __end_cc_report 05:37:02 INFO - PROCESS | 11644 | __startTimestamp1459859822805__endTimestamp 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | ------- Summary: start ------- 05:37:02 INFO - PROCESS | 11644 | Number of tests: 14 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.43 (3.0%) stddev-sans-first:3.63 05:37:02 INFO - PROCESS | 11644 | Values: 111.0 112.0 110.0 113.0 113.0 116.0 103.0 113.0 113.0 113.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:160.00 stddev:19.54 (12.2%) stddev-sans-first:20.41 05:37:02 INFO - PROCESS | 11644 | Values: 164.0 134.0 157.0 181.0 134.0 159.0 161.0 133.0 185.0 136.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 05:37:02 INFO - PROCESS | 11644 | Values: 163.0 161.0 162.0 161.0 161.0 161.0 164.0 164.0 162.0 162.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#3] audio-fft Cycles:10 Average:86.10 Median:73.50 stddev:15.97 (21.7%) stddev-sans-first:16.33 05:37:02 INFO - PROCESS | 11644 | Values: 74.0 75.0 103.0 98.0 73.0 73.0 73.0 114.0 101.0 77.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:94.00 stddev:23.73 (25.2%) stddev-sans-first:24.49 05:37:02 INFO - PROCESS | 11644 | Values: 93.0 96.0 146.0 94.0 93.0 94.0 147.0 94.0 94.0 135.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:37:02 INFO - PROCESS | 11644 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 05:37:02 INFO - PROCESS | 11644 | Values: 145.0 147.0 146.0 146.0 146.0 145.0 145.0 148.0 146.0 146.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:37:02 INFO - PROCESS | 11644 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:66.50 stddev:4.06 (6.1%) stddev-sans-first:4.24 05:37:02 INFO - PROCESS | 11644 | Values: 65.0 67.0 73.0 67.0 66.0 66.0 66.0 75.0 62.0 63.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 05:37:02 INFO - PROCESS | 11644 | Values: 63.0 63.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.50 stddev:2.33 (2.8%) stddev-sans-first:2.45 05:37:02 INFO - PROCESS | 11644 | Values: 82.0 83.0 84.0 82.0 83.0 82.0 81.0 81.0 89.0 82.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.50 stddev:2.77 (2.3%) stddev-sans-first:2.83 05:37:02 INFO - PROCESS | 11644 | Values: 123.0 122.0 118.0 125.0 119.0 120.0 121.0 121.0 116.0 124.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:140.50 stddev:3.46 (2.5%) stddev-sans-first:3.17 05:37:02 INFO - PROCESS | 11644 | Values: 134.0 142.0 142.0 140.0 140.0 132.0 139.0 142.0 138.0 141.0 05:37:02 INFO - PROCESS | 11644 | 05:37:02 INFO - PROCESS | 11644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:0.88 (1.3%) stddev-sans-first:0.93 05:37:02 INFO - PROCESS | 11644 | Values: 67.0 66.0 68.0 68.0 67.0 66.0 68.0 67.0 68.0 66.0 05:37:02 INFO - PROCESS | 11644 | -------- Summary: end -------- 05:37:02 INFO - PROCESS | 11644 | 05:37:03 INFO - TEST-INFO | 11644: exit 0 05:37:03 INFO - TEST-OK | kraken | took 62144ms 05:37:03 INFO - SUITE-END | took 1178s 05:37:03 INFO - Completed test suite (00:19:38) 05:37:03 INFO - javascript benchmark 05:37:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2580.522603318386, 2613.725558816323, 2659.3484596273915, 2675.906343277986, 2690.6098615700716, 4476.0824031073635, 4540.3870477485525, 4548.658850586206, 4554.72671639701, 4576.1991651460985, 4534.56921592449, 4568.703034302768, 4573.13110509003, 4602.8619141425725, 4629.213033784256, 4167.333226683716, 4184.686148538856, 4257.233697934371, 4280.293751530994, 4348.630366418858, 4252.0858015526655, 4318.892027699301, 4326.718763280377, 4328.675349348796, 4333.393324934496, 4102.671786257107, 4184.0, 4280.871573852758, 4285.914281714379, 4295.291276939332, 4204.810783514749, 4228.5348611653, 4243.533211346749, 4246.214450326668, 4285.292926667096, 4215.114825886568, 4217.704760666755, 4224.936625950613, 4246.363045543162, 4258.936115958263, 4254.191703576311, 4363.410939523155, 4384.912301753947, 4440.511543730187, 4477.283634618446, 4825.879353016203, 4860.854174374775, 4865.635077369176, 4884.047610715912, 4910.165271903785, 4760.381150450419, 4899.240617704261, 4905.460399356068, 4916.60667146631, 4966.5778408835295, 4556.179887620227, 4598.172328980749, 4600.309953506934, 4640.6751527393435, 4647.465541462708, 4904.337914381585, 4922.655414120977, 4940.481249468826, 4943.777530011158, 4960.975195124001, 4721.0, 4724.622030237572, 4729.834455794031, 4742.691725037862, 4811.49479304675, 4906.460289368167, 4925.113479573711, 4927.802887884444, 4944.258361245842, 4972.627052971042, 4848.521201033718, 4865.197242454955, 4875.366202393737, 4878.170710979142, 4917.754112294442, 4675.322078298627, 4797.18447863864, 4861.683990540603, 4895.779689913962, 4896.583790377857, 4148.875533733993, 4158.37624356349, 4166.7708276045105, 4184.581541845852, 4215.114825886537, 3593.82030898454, 3594.8382322795014, 3598.7480876338927, 3636.3999940009603, 3639.2721455708966, 4107.8973025674595, 4160.563140870226, 4184.100418410057, 4222.978885105555, 4294.7852607369505, 4829.154897892855, 4837.129316723023, 4841.806327746851, 4864.975675121602, 4865.878353041202, 4180.6446452051305, 4180.979095104505, 4182.707210495297, 4182.996080940613, 4219.493660760729, 4407.537208593116, 4425.114977004612, 4455.22033644111, 4513.661475389359, 4534.523874993079, 4621.3068039793625, 4625.442930578537, 4646.907061858811, 4649.093426781745, 4702.03608260299, 4857.854264372075, 4866.221404575251, 4873.707577545359, 4879.829205977916, 4927.113119638356, 4553.817847286072, 4658.091672123904, 4720.834770783006, 4732.053589282226, 4769.0, 4770.475247722818, 4773.952260477351, 4788.0, 4797.520247975174, 4840.249761287007, 4714.528547145258, 4803.231482962709, 4809.398825146856, 4824.758762061953, 4878.438979517401, 4633.2818413146015, 4679.134360143385, 4687.531246875285, 4714.057188562233, 4725.952740472689, 4642.350070989996, 4670.3228031934495, 4672.953270467252, 4684.110019096361, 4716.528347165256, 4506.346579745853, 4623.953760462352, 4631.652626052992, 4633.837815676435, 4692.530746925417, 4736.076465089274, 4758.452777930583, 4772.093302272557, 4802.711837289634, 4802.903941921212, 4661.8135274589995, 4664.3469914211355, 4666.066786642617, 4670.9766451167525, 4711.034237981137], "unit": "score", "name": "dojo.html", "value": 4483.210931040424}, {"lowerIsBetter": false, "replicates": [513.2532165698906, 528.363322196753, 550.54029885046, 566.5609152906497, 570.9286339207598, 27236.319092022684, 27714.584281235773, 27724.0, 34895.65104348956, 35344.646553534454, 37857.43213851788, 38443.231135377275, 38506.80746596263, 38514.422283665765, 38619.22761544767, 7762.107357653871, 8046.758597242092, 8053.073896501889, 8054.395920305971, 8058.516489010649, 7927.1676473970265, 8092.2716955474, 8099.109097999215, 8111.553864537448, 8112.837743245132, 8032.3574114071025, 8132.959335203315, 8139.226773456512, 8146.75559733206, 8148.144444833296, 7995.800104997393, 8046.436749427542, 8060.0, 8061.113277539466, 8079.555624440653, 7865.803354916173, 7978.840423191504, 7979.680812767482, 7986.880196797053, 8008.959955200245, 37829.432558511646, 38334.80832595847, 38360.616393836266, 38382.0, 38400.61599383999, 2875.6405449318836, 3043.1107354184187, 3184.299454120113, 3293.5059741038795, 3797.1456422305037, 28681.086193593266, 28814.135575932545, 29254.122376328745, 29579.556306655417, 29849.70150298491, 3368.2253081791323, 3429.0741499794917, 3437.346904088215, 3446.483027545863, 3621.203335266237, 236496.0, 236897.0, 237380.0, 237424.81287593624, 237843.99999999828, 42660.78669606694, 56040.0, 56782.43217567854, 56801.0, 56889.14666280009, 40264.0, 40446.79776601098, 40501.39247911284, 40563.39154912678, 40612.39081413781, 13602.795958060438, 13825.308734563432, 13825.930870345584, 13838.792418113737, 13842.723145537235, 10739.194560408001, 10867.565297388015, 10875.51060202277, 10877.891221087846, 10878.673639790819, 14358.138511689333, 14382.35279412429, 14856.33146508388, 14978.176200309088, 15045.322960466805, 5759.1937128802, 5866.354700982888, 5884.882302354014, 5970.104484327386, 5989.670568118708, 829.126174844855, 879.3448880583878, 883.0286684646837, 907.8728977943093, 996.0537489384968, 25978.480430391286, 26284.0, 26393.0, 26484.735152648613, 26660.60009099865, 850.306999795165, 941.7268991992382, 996.3175224970918, 1001.2740762946951, 1010.6260683547134, 12721.236725796482, 12824.679383015498, 12946.287954162612, 13008.414621341873, 13017.47930082805, 275946.0, 281731.0, 283083.0, 283107.0, 283918.0, 46679.29981050287, 47697.0, 47824.0, 47967.0, 48105.0, 1026.5688410867303, 1185.697647099984, 1235.1354052163522, 1246.059225284886, 1269.7523982823445, 24616.138435154684, 24911.501769964863, 25096.498070038862, 25129.497410051332, 25132.49735005326, 34761.65238347584, 35073.64926350704, 35149.824250878584, 35210.0, 35227.0, 166516.0, 167972.0, 168013.0, 168089.0, 168587.0, 27060.864695676395, 29610.407791844475, 31725.84137079392, 32114.03657890267, 32207.51688724718, 34901.301973960886, 35903.820480897426, 36290.0, 36319.0, 36702.63297366992, 32542.837285814367, 33268.833655831564, 33476.66523334833, 33556.83221583877, 34059.82970085134, 32501.837490812395, 32639.836800815843, 32830.67169328276, 32847.34305313833, 33220.66779332176, 32686.83656581702, 33032.0, 33348.66651333553, 33552.16119597029, 33678.66321336755, 27422.314442138308, 29423.26441838971, 29518.55722164212, 29586.408271834873, 29769.5534566986, 23306.417339565967, 23493.17773877906, 23576.6463503051, 23694.407639809142, 23727.881360593088], "unit": "score", "name": "ext.html", "value": 16196.204665179099}, {"lowerIsBetter": false, "replicates": [340.7223113162774, 343.3476394849785, 345.9048761590563, 346.6117947898354, 356.611293689878, 14859.702805943874, 15342.309596068177, 15965.84034159658, 16368.181590920436, 16423.17884105793, 10295.22785791065, 10731.678049658503, 10738.463076846147, 15934.282957266922, 16262.7560586591, 4517.661175411833, 4645.303204519315, 4646.3495110684535, 4648.372469716579, 4670.252759558472, 4452.3544086107495, 4592.357070010201, 4605.539446055384, 4618.35343051973, 4633.2586786114225, 4602.493725690171, 4608.746518941457, 4612.377329060568, 4619.422572178478, 4631.675782695213, 4572.359869618256, 4636.513166117543, 4643.837465688702, 4644.767761611923, 4647.6281897448125, 4524.638028957708, 4534.523874993111, 4553.658475614342, 4558.8632341029825, 4560.703554268962, 18964.336248231382, 19145.425637230765, 19517.414477565697, 19773.80226197734, 19784.406467805988, 1811.9852882385774, 1867.9252829886789, 1969.2123150739676, 2136.925207617726, 2226.0, 9030.458172509605, 9114.635414583408, 9362.90637093627, 9365.391249568756, 9560.28297877655, 1716.5622766194665, 1726.7496213049037, 1763.2543781656195, 1776.404904357042, 1866.0576408913412, 58919.41080589182, 60187.69906150485, 60293.397066029655, 60856.69571652158, 61327.0, 9537.14165725088, 9562.330636855493, 9626.037396260457, 9632.325737198329, 9776.413415195111, 12974.481020759064, 13169.67075823093, 13207.537736179187, 13219.801702974462, 13225.338733063309, 7135.357817796424, 7186.281371862877, 7201.747938822116, 7332.706691732271, 7340.522866013799, 6968.965155174293, 6976.895346569806, 6980.476464265201, 7059.8235044123285, 7066.046083778727, 4108.630223279919, 4205.411242426063, 4219.1139860629, 4255.0, 4258.382534532476, 1616.9757453638206, 1733.5406117378905, 1756.9472915812546, 1775.1922875091802, 1787.9374221902171, 851.438050886412, 854.3763052971242, 857.6312185760183, 866.8309679612541, 911.2163539356148, 15931.442399516192, 15985.920070399574, 16117.842389263327, 16329.91835040841, 16412.425565105164, 851.9872201916976, 873.5981448533746, 880.8546589812737, 894.8836651235298, 950.011987532958, 9149.268058555299, 9269.860952085724, 9297.907020929839, 9372.297077719199, 9465.242780577537, 379570.0, 388710.0, 391452.0, 396898.0, 399022.0, 67779.3222067773, 69042.0, 69337.65331173413, 70576.29423705697, 70789.6460517694, 936.4240991790136, 949.050949050949, 975.5561219645044, 1002.6540843409012, 1008.0977525114981, 14381.9280903599, 14618.780718289021, 14644.12135271887, 14799.704005920037, 14858.479953201586, 32753.672463276016, 33703.0, 34421.139471513416, 34624.134396640286, 34679.65320346764, 41697.0, 43043.13913721771, 43646.0, 46866.0, 47630.0, 6955.443564514928, 7073.257307982588, 7086.716531338689, 7171.569705817667, 7222.96388518054, 7808.180141085331, 10600.04599586041, 10975.670729878117, 10995.725106872393, 11048.558057677603, 9548.331616786758, 9693.176080032994, 9698.418094914328, 9772.364796288219, 9937.0, 9325.673601423918, 9883.654072107442, 9975.45135017581, 10031.598736050477, 10411.271211015157, 10319.638812641522, 10340.172786177238, 10424.270301078852, 10512.31669941482, 10518.0, 7133.536320139382, 7194.604296763729, 7330.5968171751065, 7395.963020184865, 7793.10379306387, 10124.0, 10258.0, 10338.328008679411, 10398.324108932895, 10494.842577361193], "unit": "score", "name": "jquery.html", "value": 7743.992367591195}, {"lowerIsBetter": false, "replicates": [1172.5485688010112, 1379.8551152129025, 1392.4778208171936, 1536.6158460384904, 1737.2095696458105, 7021.648917554121, 7162.212156662763, 7176.174739904913, 7196.280371962801, 7205.531640443374, 7066.681999310031, 7183.497155199138, 7201.2438693937165, 7207.243239459846, 7223.56658600483, 1837.7978422373528, 1878.4458584717472, 2171.207509259125, 2200.119952019193, 2220.9000594973263, 2227.888605569723, 2233.9888300558473, 2238.3061251012236, 2240.5854916840353, 2241.708577884881, 2177.68423578581, 2213.8339624528144, 2239.3505883293824, 2239.540894116702, 2252.8986195621237, 2185.0604240176717, 2224.2993457061057, 2227.3763346263154, 2227.7883601057874, 2243.809276211524, 2172.0117346607412, 2186.9343919682433, 2202.2952655150198, 2204.0963205085836, 2206.8344874134345, 7312.963435182844, 7331.0469638947125, 7344.926550734478, 7361.043064401647, 7367.852642947111, 4477.708948918343, 4596.931046034312, 4598.977005114986, 4621.884452888671, 4638.350630911675, 2861.828290302568, 2869.956950645742, 2902.782291328159, 2905.142982820052, 3014.668386477486, 936.9063093690645, 965.9275554333453, 968.1963969904962, 979.911807937282, 992.4591097851616, 9893.752656183653, 9919.156871665917, 9921.851172232422, 9976.551055202533, 9977.351472154287, 3995.9200815983518, 4063.79681015948, 4098.139390727921, 4116.794160291974, 4133.81397837098, 8532.104129066483, 8565.571721413904, 8602.18279263469, 8605.225529702357, 8606.741797746077, 4585.082983403333, 4597.7241365518175, 4598.586127248564, 4600.4479462464715, 4603.263477843529, 3470.6529347065093, 3986.262541429787, 4119.114390406077, 4119.134981653826, 4121.855735049259, 3413.4367829307885, 3487.6512348764923, 3488.54648895647, 3499.5100685903994, 3536.8054756988613, 1134.7276653603242, 1140.1505878120854, 1140.156284349592, 1150.3615493401242, 1152.1243854670342, 1192.66605350502, 1196.1029228078942, 1197.3534291482677, 1197.467127128437, 1211.4790640024873, 6555.0, 6690.899636505456, 6725.024871393621, 6745.190577130776, 6751.729930802811, 458.24389756901377, 469.2117243031739, 473.1506945033604, 473.44843257604504, 478.1345764166869, 5067.797288108434, 5074.08666440037, 5086.465921078234, 5095.643304968691, 5119.539241468286, 8517.829643407222, 8607.18231767981, 8881.866771998426, 8887.822243555092, 8966.775830604287, 8867.290616750644, 8885.955570222108, 8954.820903581893, 8963.596638151299, 8997.190252877272, 6620.8344791380605, 6774.695138718769, 6849.1438570178725, 7013.473989450812, 7017.543859649107, 6687.030380594883, 6735.259121496533, 6738.932610673831, 6738.966305168443, 6770.1537307836525, 7830.804229894298, 7893.17121702236, 8134.75595732129, 8270.297024752723, 8276.875846862182, 7633.6564854580565, 7841.333486653698, 7851.254130857559, 7859.214078592324, 8401.579921004048, 5724.284464441945, 6119.724612392364, 6288.591241569284, 6324.272708638381, 6381.0, 6900.3444672756, 6950.235474097946, 6973.023776671169, 6987.9301206987275, 6996.300369962963, 6111.663858487826, 6269.937300626935, 6283.3088360281245, 6283.8114856554375, 6294.402031806971, 6206.565540412308, 6253.937460625336, 6287.74849006053, 6363.045543168377, 6374.776882809079, 6419.422251997343, 6445.806625801233, 6460.903086453801, 6472.126262954441, 6478.708458119301, 6135.049067394561, 6143.262808463013, 6219.720112594853, 6223.533235007302, 6224.284207316216, 6187.133801267916, 6207.0, 6217.906731399123, 6251.562390632612, 6270.874582508415], "unit": "score", "name": "mootools.html", "value": 4142.775332151066}, {"lowerIsBetter": false, "replicates": [286.71185458614104, 294.64053854297754, 299.1891972753837, 303.10281566562986, 308.11724409566597, 5188.299579556769, 5252.50101240382, 5263.631545791796, 5280.049591073605, 5285.577153827694, 5178.378594568648, 5191.922121168176, 5204.479552044793, 5231.869203269911, 5235.450277720842, 3886.8833934981994, 4002.1995600879795, 4099.159672267193, 4100.753954762717, 4120.732152410099, 4112.773797441139, 4114.7119701620895, 4121.031557583965, 4123.711340206187, 4126.174765046988, 4078.775667338295, 4091.9181616367655, 4095.877123686294, 4096.406021126935, 4098.036961314089, 3880.301545721769, 3944.8619298324707, 4005.339119045354, 4018.799060046986, 4035.515738111416, 3583.820808959568, 3584.211473475857, 3587.9820600897087, 3588.802615856127, 3596.6403359664087, 4982.725950072744, 4983.8504844854715, 4994.625403094746, 4995.300657907896, 5001.099802035668, 4662.440507139131, 4667.579917807414, 4669.066186762661, 4674.135284972291, 4678.8596342109795, 5461.69960652164, 5466.371367292772, 5470.370907345667, 5473.9452605474235, 5474.507294343528, 3926.6269704378037, 3926.8232929517953, 3927.430522574211, 3929.764214147132, 3948.1511475033008, 5511.807086751985, 5691.800786972436, 5698.259226300595, 5702.116171993348, 5704.914426283568, 3976.2842688315804, 4008.7394319369146, 4011.6991225658194, 4022.758634481882, 4025.0742329264435, 4071.307877660805, 4073.2668119738137, 4073.307537718595, 4073.837046518106, 4087.141700242982, 4614.538546145359, 4618.56123668251, 4626.398568186114, 4626.976865115653, 4631.8378856739855, 5471.042567550663, 5472.91790623141, 5475.972620136953, 5482.342118945752, 5482.862928426742, 1410.7319609274205, 1447.6091455307007, 1452.491627930216, 1455.5196785060905, 1459.3505889879114, 873.3929918706565, 907.4827348411474, 914.8719179314901, 957.5643082397493, 977.6822532676766, 4801.4718380978065, 4822.831200908022, 4833.709977401367, 4839.733814640229, 4847.733374664427, 5631.831045068655, 5640.492355688008, 5644.181593668895, 5650.689212093293, 5684.09054551278, 4805.879853003703, 4827.034593081397, 4832.540908613746, 4835.323054772335, 4837.911469919311, 3024.168353702705, 3055.236190952262, 3056.1595561220397, 3061.770367222467, 3065.5401689746272, 5377.892442151135, 5399.865003374947, 5414.593905457028, 5422.240886275925, 5424.077906755782, 5631.8592035199445, 5813.186153938452, 5815.505682016991, 5816.185733997244, 5822.184894114827, 5379.569634429236, 5389.649672771257, 5392.487713667196, 5399.541039011728, 5408.0, 5655.7454914528125, 5656.0, 5656.264685591012, 5664.943350566442, 5666.490015898589, 5506.146547285177, 5537.307836520435, 5544.306961629796, 5549.112142057252, 5563.666180029211, 5382.246485491956, 5396.406395296436, 5405.756740946588, 5405.945940540544, 5412.323459567554, 3738.8130593469673, 3819.1788765415567, 3858.0740622249896, 3867.7679339239735, 3881.8835434936996, 5442.346918369821, 5569.888602228014, 5601.29983752031, 5636.098224284095, 5650.0, 5482.616216864941, 5492.258545096521, 5498.945010550004, 5533.5849811263515, 5559.916601250903, 5269.104252277046, 5370.704611246263, 5492.313460817398, 5499.202615620633, 5500.449955004628, 5395.595330350161, 5404.243405923095, 5426.593005524523, 5470.288862447856, 5480.506754392124, 5567.832965011056, 5569.916451253315, 5579.0, 5582.16267559853, 5587.413321601173, 5403.756830942696, 5434.0, 5446.183072539151, 5447.591430642638, 5448.564114870722], "unit": "score", "name": "prototype.html", "value": 4131.705795654008}, {"lowerIsBetter": false, "replicates": [600.128528350388, 620.6307247187922, 741.7700512841017, 753.491393309516, 770.3644493293035, 11812.409379531022, 11925.940370298158, 11964.760704785898, 11971.341576213315, 12006.219595726272, 11356.659300220987, 11359.943200284008, 11369.602063927765, 11390.829137562923, 11442.7139321517, 621.692262330146, 785.308928143236, 799.220759759233, 810.2464707821723, 810.4934415990007, 799.2367289238763, 800.5476905548376, 805.375833728859, 805.9274665280124, 807.8747794091926, 657.697459168783, 829.4525613095358, 831.9417640765149, 832.5545832979358, 835.0939230934413, 823.4935514658472, 836.6318819719304, 838.8028813228948, 839.0812060793452, 839.1398816213369, 615.4983688294026, 617.4227097663654, 618.6999305336954, 619.3899009475663, 619.7304172684896, 12424.627261182179, 12528.0, 12548.937255313756, 12571.245725256422, 12576.434060467302, 11363.318200907972, 11556.53773849045, 11798.233114847508, 11942.0, 12183.51265949361, 8611.224989750952, 8650.351223658188, 8674.522901240429, 8765.167309105625, 8910.242629376446, 3318.6847249511256, 3324.1024923270825, 3351.0449521886144, 3352.0614228016193, 3417.79493230407, 42633.78683106565, 42833.35749963753, 42865.57134428647, 42921.0, 42950.78524607388, 9179.357444978787, 9546.0, 9575.180715664, 9677.274204434696, 9686.418814871131, 17382.91308543449, 17431.0, 17445.825541744674, 17457.21442535089, 17476.825231747775, 6512.34876512345, 6632.602043877383, 6657.635184787107, 6730.764423245163, 6735.057092007123, 3650.142216579102, 3656.74402791802, 3660.432632941898, 3666.4683620874825, 3719.8512059517316, 2732.9316767080586, 2740.725927407283, 2753.435545713124, 2757.696653368128, 2761.1854502921688, 501.94729553396365, 538.7737150396842, 543.4511143744846, 544.0750723769607, 549.4395716369361, 494.695762106302, 532.3718012744921, 538.9110796718497, 558.0318148013193, 575.6776205325032, 7490.288422599844, 7641.0, 7702.537847729154, 7710.730124445618, 7718.922810771933, 542.782886845265, 559.7732918168149, 562.2662425534635, 564.5850300029475, 566.3854717631416, 3442.5868895732674, 3631.418972964313, 3678.797666128335, 3698.500702405141, 3935.665468435158, 47031.0, 49988.250176247384, 50061.0, 50091.749541252786, 50158.247626285636, 44118.33822492665, 44339.11321773547, 44438.77780611076, 44453.0, 44748.3287750684, 41325.79337103295, 42445.0, 42515.7874210627, 42815.14369712588, 43009.569904301185, 7732.497387669783, 7901.0, 7936.882233881594, 7980.640871160927, 8055.1944805521325, 30651.693483064882, 31526.842365788023, 32651.510227346134, 33163.17092072718, 33314.66685333213, 36959.815200923826, 38330.61669383271, 40294.59705403026, 40600.39099413452, 40746.59253407546, 9875.20998320147, 9889.55497002651, 9943.30396872212, 9948.0, 9978.101970822661, 9852.0, 10611.575536978435, 10731.087857532197, 10740.087092597218, 10787.67636970892, 10020.64927727526, 10069.244806639384, 10357.415739876087, 10544.209184311361, 10554.947225263824, 10009.499525023573, 10011.399316041061, 10050.145737612385, 10110.443925584164, 10585.100266477128, 9532.142107210384, 9602.32783705134, 9702.417854928726, 9860.950695246478, 9892.356996795184, 8743.693970711249, 8936.731898043068, 9053.411528250643, 9059.592318345558, 9153.405028673114, 8832.5583720815, 8859.158379953895, 8930.732078037669, 8944.150305720947, 9267.258619310303], "unit": "score", "name": "yui.html", "value": 5718.807001442079}], "name": "dromaeo_css", "value": 6167.693520029388}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 110.0, 113.0, 113.0, 116.0, 103.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [164.0, 134.0, 157.0, 181.0, 134.0, 159.0, 161.0, 133.0, 185.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 154.4}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 161.0, 161.0, 161.0, 164.0, 164.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 103.0, 98.0, 73.0, 73.0, 73.0, 114.0, 101.0, 77.0], "unit": "score", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [93.0, 96.0, 146.0, 94.0, 93.0, 94.0, 147.0, 94.0, 94.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0, 148.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 73.0, 67.0, 66.0, 66.0, 66.0, 75.0, 62.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 67.0}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 82.0, 83.0, 82.0, 81.0, 81.0, 89.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 118.0, 125.0, 119.0, 120.0, 121.0, 121.0, 116.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [134.0, 142.0, 142.0, 140.0, 140.0, 132.0, 139.0, 142.0, 138.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 68.0, 67.0, 66.0, 68.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1521.7000000000003}]} 05:37:04 INFO - Return code: 0 05:37:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:37:04 ERROR - # TBPL SUCCESS # 05:37:04 INFO - Running post-action listener: _resource_record_post_action 05:37:04 INFO - Running post-run listener: _resource_record_post_run 05:37:05 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 526692352; Read time: 0; Write time: 568388 05:37:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242454528; Read time: 0; Write time: 368064 05:37:05 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 284188672; Read time: 0; Write time: 200304 05:37:05 INFO - Running post-run listener: _upload_blobber_files 05:37:05 INFO - Blob upload gear active. 05:37:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:05 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 05:37:05 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'] 05:37:05 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 05:37:05 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:06 INFO - (blobuploader) - INFO - Done attempting. 05:37:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:07 INFO - (blobuploader) - INFO - Done attempting. 05:37:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:07 INFO - Return code: 0 05:37:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8aed7b11dfba5f4c500653f1305b7957a42a4e21cdffdb40f78b13f6c110cf1461f4a4777c12a0189db7e84f5299e7f9eb83c44635e23651e65e615dba6f8fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed927d73d6d6c08cb8c7ed56f5c9003dbb0d110d0261bdbf395451fb2155e707a2bf2e5362546ff0f31d0e3ba5c99f76a41d5dcef130f678fd00232c6fec4f49"} 05:37:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:07 INFO - Contents: 05:37:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8aed7b11dfba5f4c500653f1305b7957a42a4e21cdffdb40f78b13f6c110cf1461f4a4777c12a0189db7e84f5299e7f9eb83c44635e23651e65e615dba6f8fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed927d73d6d6c08cb8c7ed56f5c9003dbb0d110d0261bdbf395451fb2155e707a2bf2e5362546ff0f31d0e3ba5c99f76a41d5dcef130f678fd00232c6fec4f49"} 05:37:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:07 INFO - Copying logs to upload dir... 05:37:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.273550 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-05 05:37:07.235603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 05:37:07.239104) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164 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/c8aed7b11dfba5f4c500653f1305b7957a42a4e21cdffdb40f78b13f6c110cf1461f4a4777c12a0189db7e84f5299e7f9eb83c44635e23651e65e615dba6f8fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed927d73d6d6c08cb8c7ed56f5c9003dbb0d110d0261bdbf395451fb2155e707a2bf2e5362546ff0f31d0e3ba5c99f76a41d5dcef130f678fd00232c6fec4f49"} build_url:https://queue.taskcluster.net/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/CzNE3IWjR7iNnXizPzmd9g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8aed7b11dfba5f4c500653f1305b7957a42a4e21cdffdb40f78b13f6c110cf1461f4a4777c12a0189db7e84f5299e7f9eb83c44635e23651e65e615dba6f8fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed927d73d6d6c08cb8c7ed56f5c9003dbb0d110d0261bdbf395451fb2155e707a2bf2e5362546ff0f31d0e3ba5c99f76a41d5dcef130f678fd00232c6fec4f49"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 05:37:07.264328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:37:07.264715) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459858591.997096-841925164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004736 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:37:07.348050) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 05:37:07.348414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 05:37:07.348764) ========= ========= Total master_lag: 0.27 =========