builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1459565051.27 results: success (0) buildid: 20160401190750 builduid: 95dea9c87d1b4d358b96cfa596a1d2ee revision: d080043beed9d866ef0e5591e5c23b243d10992e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.267293) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.267715) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.272575) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006462 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.350313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.350650) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.452712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.452979) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.510805) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.511102) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.513494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.513777) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 19:44:11-- 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% 33.7M=0s 2016-04-01 19:44:11 (33.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.623255) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.623602) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019298 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.673090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:11.673453) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d080043beed9d866ef0e5591e5c23b243d10992e --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 d080043beed9d866ef0e5591e5c23b243d10992e --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=fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 19:44:11,835 truncating revision to first 12 chars 2016-04-01 19:44:11,835 Setting DEBUG logging. 2016-04-01 19:44:11,835 attempt 1/10 2016-04-01 19:44:11,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d080043beed9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 19:44:12,085 unpacking tar archive at: fx-team-d080043beed9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520513 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:12.206383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:12.206682) ========= echo d080043beed9d866ef0e5591e5c23b243d10992e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd080043beed9d866ef0e5591e5c23b243d10992e'] 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=fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d080043beed9d866ef0e5591e5c23b243d10992e program finished with exit code 0 elapsedTime=0.004711 script_repo_revision: 'd080043beed9d866ef0e5591e5c23b243d10992e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:12.256542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:12.256822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 19:44:12.268093) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-01 19:44:12.268484) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:44:12 INFO - MultiFileLogger online at 20160401 19:44:12 in /builds/slave/test 19:44:12 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 19:44:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:44:12 INFO - {'append_to_log': False, 19:44:12 INFO - 'base_work_dir': '/builds/slave/test', 19:44:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:44:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:44:12 INFO - 'branch': 'Fx-Team-Non-PGO', 19:44:12 INFO - 'buildbot_json_path': 'buildprops.json', 19:44:12 INFO - 'config_files': ('talos/linux_config.py',), 19:44:12 INFO - 'default_actions': ('clobber', 19:44:12 INFO - 'read-buildbot-config', 19:44:12 INFO - 'download-and-extract', 19:44:12 INFO - 'populate-webroot', 19:44:12 INFO - 'create-virtualenv', 19:44:12 INFO - 'install', 19:44:12 INFO - 'run-tests'), 19:44:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:44:12 INFO - 'download_minidump_stackwalk': True, 19:44:12 INFO - 'download_symbols': 'ondemand', 19:44:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:44:12 INFO - 'tooltool.py': '/tools/tooltool.py', 19:44:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:44:12 INFO - '/tools/misc-python/virtualenv.py')}, 19:44:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:44:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:44:12 INFO - 'installer_path': 'installer.exe', 19:44:12 INFO - 'log_level': 'info', 19:44:12 INFO - 'log_name': 'talos', 19:44:12 INFO - 'log_to_console': True, 19:44:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:44:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:44:12 INFO - 'opt_config_files': (), 19:44:12 INFO - 'pip_index': False, 19:44:12 INFO - 'sps_profile': False, 19:44:12 INFO - 'sps_profile_interval': 0, 19:44:12 INFO - 'suite': 'dromaeojs', 19:44:12 INFO - 'system_bits': '32', 19:44:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:44:12 INFO - 'title': 'talos-linux64-ix-014', 19:44:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:44:12 INFO - 'use_talos_json': True, 19:44:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:44:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:44:12 INFO - 'work_dir': 'build'} 19:44:12 INFO - ##### 19:44:12 INFO - ##### Running clobber step. 19:44:12 INFO - ##### 19:44:12 INFO - Running pre-action listener: _resource_record_pre_action 19:44:12 INFO - Running main action method: clobber 19:44:12 INFO - rmtree: /builds/slave/test/build 19:44:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:44:12 INFO - Running post-action listener: _resource_record_post_action 19:44:12 INFO - ##### 19:44:12 INFO - ##### Running read-buildbot-config step. 19:44:12 INFO - ##### 19:44:12 INFO - Running pre-action listener: _resource_record_pre_action 19:44:12 INFO - Running main action method: read_buildbot_config 19:44:12 INFO - Using buildbot properties: 19:44:12 INFO - { 19:44:12 INFO - "project": "", 19:44:12 INFO - "product": "firefox", 19:44:12 INFO - "script_repo_revision": "production", 19:44:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:44:12 INFO - "repository": "", 19:44:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:44:12 INFO - "buildid": "20160401190750", 19:44:12 INFO - "pgo_build": "False", 19:44:12 INFO - "basedir": "/builds/slave/test", 19:44:12 INFO - "buildnumber": 1597, 19:44:12 INFO - "slavename": "talos-linux64-ix-014", 19:44:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:44:12 INFO - "platform": "ubuntu64_hw", 19:44:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:44:12 INFO - "branch": "fx-team", 19:44:12 INFO - "repo_path": "integration/fx-team", 19:44:12 INFO - "revision": "d080043beed9d866ef0e5591e5c23b243d10992e", 19:44:12 INFO - "stage_platform": "linux64", 19:44:12 INFO - "builduid": "95dea9c87d1b4d358b96cfa596a1d2ee", 19:44:12 INFO - "slavebuilddir": "test" 19:44:12 INFO - } 19:44:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:44:12 INFO - Running post-action listener: _resource_record_post_action 19:44:12 INFO - ##### 19:44:12 INFO - ##### Running download-and-extract step. 19:44:12 INFO - ##### 19:44:12 INFO - Running pre-action listener: _resource_record_pre_action 19:44:12 INFO - Running main action method: download_and_extract 19:44:12 INFO - mkdir: /builds/slave/test/build/tests 19:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:12 INFO - https://queue.taskcluster.net/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:44:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:44:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:44:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/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 19:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/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 19:44:22 INFO - Downloaded 1361 bytes. 19:44:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:44:22 INFO - Using the following test package requirements: 19:44:22 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:44:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:44:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:22 INFO - u'jsshell-linux-x86_64.zip'], 19:44:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:44:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:44:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:44:22 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:44:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:44:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:44:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:44:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:44:22 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')]} 19:44:22 INFO - https://queue.taskcluster.net/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:44:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:44:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:44:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/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 19:44:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/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 19:44:34 INFO - Downloaded 22115802 bytes. 19:44:34 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'] 19:44:34 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 19:44:35 INFO - Return code: 0 19:44:35 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 19:44:35 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')]} 19:44:35 INFO - https://queue.taskcluster.net/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/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 19:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/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 19:44:37 INFO - Downloaded 22115802 bytes. 19:44:37 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'] 19:44:37 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 19:44:38 INFO - Return code: 0 19:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:38 INFO - https://queue.taskcluster.net/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:44:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:44:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/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 19:44:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/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 19:44:39 INFO - Downloaded 10847584 bytes. 19:44:39 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'] 19:44:39 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 19:44:39 INFO - Return code: 0 19:44: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')]} 19:44:39 INFO - https://queue.taskcluster.net/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:44:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:44:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:44:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/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 19:44:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHxuU5GDTZK523r17RNR_Q/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 19:44:41 INFO - Downloaded 54243593 bytes. 19:44:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:44:41 INFO - mkdir: /builds/slave/test/properties 19:44:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:44:41 INFO - Writing to file /builds/slave/test/properties/build_url 19:44:41 INFO - Contents: 19:44:41 INFO - build_url:https://queue.taskcluster.net/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:44:41 INFO - Running post-action listener: _resource_record_post_action 19:44:41 INFO - Running post-action listener: set_extra_try_arguments 19:44:41 INFO - ##### 19:44:41 INFO - ##### Running populate-webroot step. 19:44:41 INFO - ##### 19:44:41 INFO - Running pre-action listener: _resource_record_pre_action 19:44:41 INFO - Running main action method: populate_webroot 19:44:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:44:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:44:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:44:41 INFO - '--tppagecycles', 19:44:41 INFO - '7'], 19:44:41 INFO - 'tests': ['tsvgm']}}, 19:44:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:44:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:44:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:44:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:44:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:44:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:44:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:41 INFO - 'talos_options': ['--e10s'], 19:44:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:41 INFO - 'tests': ['damp', 'tps']}, 19:44:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:41 INFO - 'talos_options': ['--e10s'], 19:44:41 INFO - 'tests': ['damp', 'tps']}, 19:44:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:44:41 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 19:44:41 INFO - 'tests': ['dromaeo_dom']}, 19:44:41 INFO - 'other': {'tests': ['a11yr', 19:44:41 INFO - 'ts_paint', 19:44:41 INFO - 'tpaint', 19:44:41 INFO - 'sessionrestore', 19:44:41 INFO - 'sessionrestore_no_auto_restore', 19:44:41 INFO - 'tabpaint']}, 19:44:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:44:41 INFO - 'tests': ['a11yr', 19:44:41 INFO - 'ts_paint', 19:44:41 INFO - 'tpaint', 19:44:41 INFO - 'sessionrestore', 19:44:41 INFO - 'sessionrestore_no_auto_restore', 19:44:41 INFO - 'tabpaint']}, 19:44:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:44:41 INFO - 'tests': ['a11yr', 19:44:41 INFO - 'ts_paint', 19:44:41 INFO - 'tpaint', 19:44:41 INFO - 'sessionrestore', 19:44:41 INFO - 'sessionrestore_no_auto_restore', 19:44:41 INFO - 'tabpaint']}, 19:44:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:44:41 INFO - 'tests': ['a11yr', 19:44:41 INFO - 'ts_paint', 19:44:41 INFO - 'tpaint', 19:44:41 INFO - 'sessionrestore', 19:44:41 INFO - 'sessionrestore_no_auto_restore', 19:44:41 INFO - 'tabpaint']}, 19:44:41 INFO - 'other_l64': {'tests': ['a11yr', 19:44:41 INFO - 'ts_paint', 19:44:41 INFO - 'tpaint', 19:44:41 INFO - 'sessionrestore', 19:44:41 INFO - 'sessionrestore_no_auto_restore', 19:44:41 INFO - 'tabpaint']}, 19:44:41 INFO - 'other_nol64': {'tests': ['a11yr', 19:44:41 INFO - 'ts_paint', 19:44:41 INFO - 'tpaint', 19:44:41 INFO - 'sessionrestore', 19:44:41 INFO - 'sessionrestore_no_auto_restore', 19:44:41 INFO - 'tabpaint']}, 19:44:41 INFO - 'svgr': {'tests': ['tsvgx', 19:44:41 INFO - 'tsvgr_opacity', 19:44:41 INFO - 'tart', 19:44:41 INFO - 'tscrollx', 19:44:41 INFO - 'cart']}, 19:44:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:44:41 INFO - 'tests': ['tsvgx', 19:44:41 INFO - 'tsvgr_opacity', 19:44:41 INFO - 'tart', 19:44:41 INFO - 'tscrollx', 19:44:41 INFO - 'cart']}, 19:44:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:41 INFO - 'tests': ['tp5o']}, 19:44:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:41 INFO - 'talos_options': ['--e10s'], 19:44:41 INFO - 'tests': ['tp5o']}, 19:44:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:41 INFO - 'talos_options': ['--xperf_path', 19:44:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:41 INFO - 'tests': ['tp5n']}, 19:44:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:41 INFO - 'talos_options': ['--e10s', 19:44:41 INFO - '--xperf_path', 19:44:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:41 INFO - 'tests': ['tp5n']}}, 19:44:41 INFO - 'talos.zip': {'path': '', 19:44:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:44:41 INFO - Running post-action listener: _resource_record_post_action 19:44:41 INFO - ##### 19:44:41 INFO - ##### Running create-virtualenv step. 19:44:41 INFO - ##### 19:44:41 INFO - Running pre-action listener: _resource_record_pre_action 19:44:41 INFO - Running main action method: create_virtualenv 19:44:41 INFO - Creating virtualenv /builds/slave/test/build/venv 19:44:41 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 19:44:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:44:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:44:41 INFO - Using real prefix '/usr' 19:44:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:44:42 INFO - Installing distribute.............................................................................................................................................................................................done. 19:44:44 INFO - Installing pip.................done. 19:44:44 INFO - Return code: 0 19:44:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6670ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b410>, '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 0x286c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', '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 19:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:44:44 INFO - Using env: {'DISPLAY': ':0', 19:44:44 INFO - 'HOME': '/home/cltbld', 19:44:44 INFO - 'LANG': 'en_US.UTF-8', 19:44:44 INFO - 'LANGUAGE': 'en_US:en', 19:44:44 INFO - 'LOGNAME': 'cltbld', 19:44:44 INFO - 'MAIL': '/var/mail/cltbld', 19:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:44 INFO - 'MOZ_NO_REMOTE': '1', 19:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:44 INFO - 'NO_EM_RESTART': '1', 19:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:44 INFO - 'PWD': '/builds/slave/test', 19:44:44 INFO - 'SHELL': '/bin/bash', 19:44:44 INFO - 'SHLVL': '1', 19:44:44 INFO - 'TERM': 'linux', 19:44:44 INFO - 'TMOUT': '86400', 19:44:44 INFO - 'USER': 'cltbld', 19:44:44 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', 19:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:44 INFO - '_': '/tools/buildbot/bin/python'} 19:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:44 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 19:44:44 INFO - Cleaning up... 19:44:44 INFO - Return code: 0 19:44:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6670ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b410>, '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 0x286c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', '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 19:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:44:44 INFO - Using env: {'DISPLAY': ':0', 19:44:44 INFO - 'HOME': '/home/cltbld', 19:44:44 INFO - 'LANG': 'en_US.UTF-8', 19:44:44 INFO - 'LANGUAGE': 'en_US:en', 19:44:44 INFO - 'LOGNAME': 'cltbld', 19:44:44 INFO - 'MAIL': '/var/mail/cltbld', 19:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:44 INFO - 'MOZ_NO_REMOTE': '1', 19:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:44 INFO - 'NO_EM_RESTART': '1', 19:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:44 INFO - 'PWD': '/builds/slave/test', 19:44:44 INFO - 'SHELL': '/bin/bash', 19:44:44 INFO - 'SHLVL': '1', 19:44:44 INFO - 'TERM': 'linux', 19:44:44 INFO - 'TMOUT': '86400', 19:44:44 INFO - 'USER': 'cltbld', 19:44:44 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', 19:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:44 INFO - '_': '/tools/buildbot/bin/python'} 19:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:44 INFO - Downloading/unpacking psutil>=0.7.1 19:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:44:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:44:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:44:46 INFO - Installing collected packages: psutil 19:44:46 INFO - Running setup.py install for psutil 19:44:46 INFO - building 'psutil._psutil_linux' extension 19:44:46 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 19:44:47 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 19:44:47 INFO - building 'psutil._psutil_posix' extension 19:44:47 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 19:44:47 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 19:44:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:44:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:44:47 INFO - Successfully installed psutil 19:44:47 INFO - Cleaning up... 19:44:47 INFO - Return code: 0 19:44:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6670ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b410>, '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 0x286c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', '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 19:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:44:47 INFO - Using env: {'DISPLAY': ':0', 19:44:47 INFO - 'HOME': '/home/cltbld', 19:44:47 INFO - 'LANG': 'en_US.UTF-8', 19:44:47 INFO - 'LANGUAGE': 'en_US:en', 19:44:47 INFO - 'LOGNAME': 'cltbld', 19:44:47 INFO - 'MAIL': '/var/mail/cltbld', 19:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:47 INFO - 'MOZ_NO_REMOTE': '1', 19:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:47 INFO - 'NO_EM_RESTART': '1', 19:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:47 INFO - 'PWD': '/builds/slave/test', 19:44:47 INFO - 'SHELL': '/bin/bash', 19:44:47 INFO - 'SHLVL': '1', 19:44:47 INFO - 'TERM': 'linux', 19:44:47 INFO - 'TMOUT': '86400', 19:44:47 INFO - 'USER': 'cltbld', 19:44:47 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', 19:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:47 INFO - '_': '/tools/buildbot/bin/python'} 19:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:44:49 INFO - Installing collected packages: mozsystemmonitor 19:44:49 INFO - Running setup.py install for mozsystemmonitor 19:44:49 INFO - Successfully installed mozsystemmonitor 19:44:49 INFO - Cleaning up... 19:44:49 INFO - Return code: 0 19:44:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6670ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b410>, '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 0x286c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', '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 19:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:44:49 INFO - Using env: {'DISPLAY': ':0', 19:44:49 INFO - 'HOME': '/home/cltbld', 19:44:49 INFO - 'LANG': 'en_US.UTF-8', 19:44:49 INFO - 'LANGUAGE': 'en_US:en', 19:44:49 INFO - 'LOGNAME': 'cltbld', 19:44:49 INFO - 'MAIL': '/var/mail/cltbld', 19:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:49 INFO - 'MOZ_NO_REMOTE': '1', 19:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:49 INFO - 'NO_EM_RESTART': '1', 19:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:49 INFO - 'PWD': '/builds/slave/test', 19:44:49 INFO - 'SHELL': '/bin/bash', 19:44:49 INFO - 'SHLVL': '1', 19:44:49 INFO - 'TERM': 'linux', 19:44:49 INFO - 'TMOUT': '86400', 19:44:49 INFO - 'USER': 'cltbld', 19:44:49 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', 19:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:49 INFO - '_': '/tools/buildbot/bin/python'} 19:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:50 INFO - Downloading/unpacking blobuploader==1.2.4 19:44:50 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 19:44:50 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 19:44:50 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 19:44:50 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 19:44:50 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 19:44:50 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 19:44:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:44:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:44:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:44:52 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 19:44:52 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 19:44:52 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 19:44:52 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 19:44:52 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 19:44:52 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 19:44:52 INFO - Downloading docopt-0.6.1.tar.gz 19:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:44:52 INFO - Installing collected packages: blobuploader, requests, docopt 19:44:52 INFO - Running setup.py install for blobuploader 19:44:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:44:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:44:52 INFO - Running setup.py install for requests 19:44:53 INFO - Running setup.py install for docopt 19:44:53 INFO - Successfully installed blobuploader requests docopt 19:44:53 INFO - Cleaning up... 19:44:53 INFO - Return code: 0 19:44:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:44:53 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')]} 19:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:53 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')]} 19:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:53 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 0x7f6670ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b410>, '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 0x286c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', '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 19:44:53 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 19:44:53 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 19:44:53 INFO - Using env: {'DISPLAY': ':0', 19:44:53 INFO - 'HOME': '/home/cltbld', 19:44:53 INFO - 'LANG': 'en_US.UTF-8', 19:44:53 INFO - 'LANGUAGE': 'en_US:en', 19:44:53 INFO - 'LOGNAME': 'cltbld', 19:44:53 INFO - 'MAIL': '/var/mail/cltbld', 19:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:53 INFO - 'MOZ_NO_REMOTE': '1', 19:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:53 INFO - 'NO_EM_RESTART': '1', 19:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:53 INFO - 'PWD': '/builds/slave/test', 19:44:53 INFO - 'SHELL': '/bin/bash', 19:44:53 INFO - 'SHLVL': '1', 19:44:53 INFO - 'TERM': 'linux', 19:44:53 INFO - 'TMOUT': '86400', 19:44:53 INFO - 'USER': 'cltbld', 19:44:53 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', 19:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:53 INFO - '_': '/tools/buildbot/bin/python'} 19:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:44:53 INFO - Running setup.py (path:/tmp/pip-IWHaDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:44:53 INFO - Running setup.py (path:/tmp/pip-A375ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:44:53 INFO - Running setup.py (path:/tmp/pip-FTNGZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:44:53 INFO - Running setup.py (path:/tmp/pip-sWfmnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:44:53 INFO - Running setup.py (path:/tmp/pip-0_s4dX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:44:53 INFO - Running setup.py (path:/tmp/pip-bgIWn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:44:53 INFO - Running setup.py (path:/tmp/pip-JqknnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:44:53 INFO - Running setup.py (path:/tmp/pip-I6wKce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:44:54 INFO - Running setup.py (path:/tmp/pip-4diJNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:44:54 INFO - Running setup.py (path:/tmp/pip-uTGIK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:44:54 INFO - Running setup.py (path:/tmp/pip-QWnE4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:44:54 INFO - Running setup.py (path:/tmp/pip-yWMAUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:44:54 INFO - Running setup.py (path:/tmp/pip-AV_7nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:44:54 INFO - Running setup.py (path:/tmp/pip-gXJbBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:54 INFO - Running setup.py (path:/tmp/pip-gTcJpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:44:54 INFO - Running setup.py (path:/tmp/pip-SBzb1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:44:54 INFO - Running setup.py (path:/tmp/pip-A6eUxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:44:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:44:54 INFO - Running setup.py install for manifestparser 19:44:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:44:54 INFO - Running setup.py install for mozcrash 19:44:54 INFO - Running setup.py install for mozdebug 19:44:55 INFO - Running setup.py install for mozdevice 19:44:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:44:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:44:55 INFO - Running setup.py install for mozfile 19:44:55 INFO - Running setup.py install for mozhttpd 19:44:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:44:55 INFO - Running setup.py install for mozinfo 19:44:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:44:55 INFO - Running setup.py install for mozInstall 19:44:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:44:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:44:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:44:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:44:55 INFO - Running setup.py install for mozleak 19:44:55 INFO - Running setup.py install for mozlog 19:44:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:44:55 INFO - Running setup.py install for moznetwork 19:44:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:44:55 INFO - Running setup.py install for mozprocess 19:44:55 INFO - Running setup.py install for mozprofile 19:44:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:44:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:44:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:44:56 INFO - Running setup.py install for mozrunner 19:44:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:44:56 INFO - Running setup.py install for mozscreenshot 19:44:56 INFO - Running setup.py install for moztest 19:44:56 INFO - Running setup.py install for mozversion 19:44:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:44:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:44:56 INFO - Cleaning up... 19:44:56 INFO - Return code: 0 19:44:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:44:56 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')]} 19:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:56 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')]} 19:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:56 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 0x7f6670ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b410>, '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 0x286c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', '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 19:44:56 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 19:44:56 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 19:44:56 INFO - Using env: {'DISPLAY': ':0', 19:44:56 INFO - 'HOME': '/home/cltbld', 19:44:56 INFO - 'LANG': 'en_US.UTF-8', 19:44:56 INFO - 'LANGUAGE': 'en_US:en', 19:44:56 INFO - 'LOGNAME': 'cltbld', 19:44:56 INFO - 'MAIL': '/var/mail/cltbld', 19:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:56 INFO - 'MOZ_NO_REMOTE': '1', 19:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:56 INFO - 'NO_EM_RESTART': '1', 19:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:56 INFO - 'PWD': '/builds/slave/test', 19:44:56 INFO - 'SHELL': '/bin/bash', 19:44:56 INFO - 'SHLVL': '1', 19:44:56 INFO - 'TERM': 'linux', 19:44:56 INFO - 'TMOUT': '86400', 19:44:56 INFO - 'USER': 'cltbld', 19:44:56 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', 19:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:56 INFO - '_': '/tools/buildbot/bin/python'} 19:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:44:56 INFO - Running setup.py (path:/tmp/pip-TUMWn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:44:56 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:44:56 INFO - Running setup.py (path:/tmp/pip-pEUKZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:44:56 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:44:56 INFO - Running setup.py (path:/tmp/pip-tkoxf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:44:56 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:44:56 INFO - Running setup.py (path:/tmp/pip-7Dla0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:44:57 INFO - Running setup.py (path:/tmp/pip-l9ohiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:44:57 INFO - Running setup.py (path:/tmp/pip-2sCVRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:44:57 INFO - Running setup.py (path:/tmp/pip-4eA_Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:44:57 INFO - Running setup.py (path:/tmp/pip-bOpfaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:44:57 INFO - Running setup.py (path:/tmp/pip-wiUWEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:44:57 INFO - Running setup.py (path:/tmp/pip-M3Vuo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:44:57 INFO - Running setup.py (path:/tmp/pip-qcNzzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:44:57 INFO - Running setup.py (path:/tmp/pip-nlmg1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:44:57 INFO - Running setup.py (path:/tmp/pip-mjHxse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:44:57 INFO - Running setup.py (path:/tmp/pip-1mp2jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:57 INFO - Running setup.py (path:/tmp/pip-k3HOG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:44:57 INFO - Running setup.py (path:/tmp/pip-4a94gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:44:57 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)) 19:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:44:57 INFO - Running setup.py (path:/tmp/pip-0VZBLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:44:57 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)) 19:44:57 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)) 19:44:57 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)) 19:44:57 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)) 19:44:57 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)) 19:44:57 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)) 19:44:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:44:57 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 19:44:57 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 19:44:57 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 19:44:57 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 19:44:57 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 19:44:57 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 19:44:59 INFO - Downloading blessings-1.6.tar.gz 19:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:44:59 INFO - Installing collected packages: blessings 19:44:59 INFO - Running setup.py install for blessings 19:44:59 INFO - Successfully installed blessings 19:45:00 INFO - Cleaning up... 19:45:00 INFO - Return code: 0 19:45:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:45:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:45:00 INFO - Reading from file tmpfile_stdout 19:45:00 INFO - Current package versions: 19:45:00 INFO - argparse == 1.2.1 19:45:00 INFO - blessings == 1.6 19:45:00 INFO - blobuploader == 1.2.4 19:45:00 INFO - docopt == 0.6.1 19:45:00 INFO - manifestparser == 1.1 19:45:00 INFO - mozInstall == 1.12 19:45:00 INFO - mozcrash == 0.17 19:45:00 INFO - mozdebug == 0.1 19:45:00 INFO - mozdevice == 0.48 19:45:00 INFO - mozfile == 1.2 19:45:00 INFO - mozhttpd == 0.7 19:45:00 INFO - mozinfo == 0.9 19:45:00 INFO - mozleak == 0.1 19:45:00 INFO - mozlog == 3.1 19:45:00 INFO - moznetwork == 0.27 19:45:00 INFO - mozprocess == 0.22 19:45:00 INFO - mozprofile == 0.28 19:45:00 INFO - mozrunner == 6.11 19:45:00 INFO - mozscreenshot == 0.1 19:45:00 INFO - mozsystemmonitor == 0.0 19:45:00 INFO - moztest == 0.7 19:45:00 INFO - mozversion == 1.4 19:45:00 INFO - psutil == 3.1.1 19:45:00 INFO - requests == 1.2.3 19:45:00 INFO - wsgiref == 0.1.2 19:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:45:00 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')]} 19:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:00 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')]} 19:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:00 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 0x7f6670ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b410>, '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 0x286c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', '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 19:45:00 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 19:45:00 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 19:45:00 INFO - Using env: {'DISPLAY': ':0', 19:45:00 INFO - 'HOME': '/home/cltbld', 19:45:00 INFO - 'LANG': 'en_US.UTF-8', 19:45:00 INFO - 'LANGUAGE': 'en_US:en', 19:45:00 INFO - 'LOGNAME': 'cltbld', 19:45:00 INFO - 'MAIL': '/var/mail/cltbld', 19:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:00 INFO - 'MOZ_NO_REMOTE': '1', 19:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:00 INFO - 'NO_EM_RESTART': '1', 19:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:00 INFO - 'PWD': '/builds/slave/test', 19:45:00 INFO - 'SHELL': '/bin/bash', 19:45:00 INFO - 'SHLVL': '1', 19:45:00 INFO - 'TERM': 'linux', 19:45:00 INFO - 'TMOUT': '86400', 19:45:00 INFO - 'USER': 'cltbld', 19:45:00 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', 19:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:00 INFO - '_': '/tools/buildbot/bin/python'} 19:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 INFO - Cleaning up... 19:45:00 INFO - Return code: 0 19:45:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:45:00 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')]} 19:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:00 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')]} 19:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:00 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 0x7f6670ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b410>, '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 0x286c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', '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 19:45:00 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 19:45:00 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 19:45:00 INFO - Using env: {'DISPLAY': ':0', 19:45:00 INFO - 'HOME': '/home/cltbld', 19:45:00 INFO - 'LANG': 'en_US.UTF-8', 19:45:00 INFO - 'LANGUAGE': 'en_US:en', 19:45:00 INFO - 'LOGNAME': 'cltbld', 19:45:00 INFO - 'MAIL': '/var/mail/cltbld', 19:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:00 INFO - 'MOZ_NO_REMOTE': '1', 19:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:00 INFO - 'NO_EM_RESTART': '1', 19:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:00 INFO - 'PWD': '/builds/slave/test', 19:45:00 INFO - 'SHELL': '/bin/bash', 19:45:00 INFO - 'SHLVL': '1', 19:45:00 INFO - 'TERM': 'linux', 19:45:00 INFO - 'TMOUT': '86400', 19:45:00 INFO - 'USER': 'cltbld', 19:45:00 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', 19:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:00 INFO - '_': '/tools/buildbot/bin/python'} 19:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:00 INFO - Downloading/unpacking jsonschema 19:45:00 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 19:45:00 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 19:45:00 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 19:45:00 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 19:45:00 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 19:45:00 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 19:45:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:45:02 INFO - Downloading/unpacking functools32 (from jsonschema) 19:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:02 INFO - Downloading functools32-3.2.3-2.tar.gz 19:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:45:02 INFO - warning: no files found matching '*.txt' 19:45:02 INFO - no previously-included directories found matching 'build' 19:45:02 INFO - no previously-included directories found matching 'dist' 19:45:02 INFO - no previously-included directories found matching '.git*' 19:45:02 INFO - Installing collected packages: jsonschema, functools32 19:45:02 INFO - Running setup.py install for functools32 19:45:02 INFO - warning: no files found matching '*.txt' 19:45:02 INFO - no previously-included directories found matching 'build' 19:45:02 INFO - no previously-included directories found matching 'dist' 19:45:02 INFO - no previously-included directories found matching '.git*' 19:45:03 INFO - Successfully installed jsonschema functools32 19:45:03 INFO - Cleaning up... 19:45:03 INFO - Return code: 0 19:45:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:45:03 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')]} 19:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:03 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')]} 19:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:03 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 0x7f6670ffff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b410>, '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 0x286c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c7a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', '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 19:45:03 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 19:45:03 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 19:45:03 INFO - Using env: {'DISPLAY': ':0', 19:45:03 INFO - 'HOME': '/home/cltbld', 19:45:03 INFO - 'LANG': 'en_US.UTF-8', 19:45:03 INFO - 'LANGUAGE': 'en_US:en', 19:45:03 INFO - 'LOGNAME': 'cltbld', 19:45:03 INFO - 'MAIL': '/var/mail/cltbld', 19:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:03 INFO - 'MOZ_NO_REMOTE': '1', 19:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:03 INFO - 'NO_EM_RESTART': '1', 19:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:03 INFO - 'PWD': '/builds/slave/test', 19:45:03 INFO - 'SHELL': '/bin/bash', 19:45:03 INFO - 'SHLVL': '1', 19:45:03 INFO - 'TERM': 'linux', 19:45:03 INFO - 'TMOUT': '86400', 19:45:03 INFO - 'USER': 'cltbld', 19:45:03 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', 19:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:03 INFO - '_': '/tools/buildbot/bin/python'} 19:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:03 INFO - Downloading/unpacking flake8 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45: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 19:45:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:45:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:45:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 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 19:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:45:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:45:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:45:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:45:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:45:05 INFO - no previously-included directories found matching 'docs/_build' 19:45:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:45:05 INFO - Running setup.py install for pep8 19:45:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:45:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:45:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:45:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:45:06 INFO - no previously-included directories found matching 'docs/_build' 19:45:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:45:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:45:06 INFO - Cleaning up... 19:45:06 INFO - Return code: 0 19:45:06 INFO - Running post-action listener: _resource_record_post_action 19:45:06 INFO - Running post-action listener: _start_resource_monitoring 19:45:06 INFO - Starting resource monitoring. 19:45:06 INFO - ##### 19:45:06 INFO - ##### Running install step. 19:45:06 INFO - ##### 19:45:06 INFO - Running pre-action listener: _resource_record_pre_action 19:45:06 INFO - Running main action method: install 19:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:45:06 INFO - Reading from file tmpfile_stdout 19:45:06 INFO - Detecting whether we're running mozinstall >=1.0... 19:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:45:06 INFO - Reading from file tmpfile_stdout 19:45:06 INFO - Output received: 19:45:06 INFO - Usage: mozinstall [options] installer 19:45:06 INFO - Options: 19:45:06 INFO - -h, --help show this help message and exit 19:45:06 INFO - -d DEST, --destination=DEST 19:45:06 INFO - Directory to install application into. [default: 19:45:06 INFO - "/builds/slave/test"] 19:45:06 INFO - --app=APP Application being installed. [default: firefox] 19:45:06 INFO - mkdir: /builds/slave/test/build/application 19:45:06 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'] 19:45:06 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 19:45:22 INFO - Reading from file tmpfile_stdout 19:45:22 INFO - Output received: 19:45:22 INFO - /builds/slave/test/build/application/firefox/firefox 19:45:22 INFO - Running post-action listener: _resource_record_post_action 19:45:22 INFO - ##### 19:45:22 INFO - ##### Running run-tests step. 19:45:22 INFO - ##### 19:45:22 INFO - Running pre-action listener: _resource_record_pre_action 19:45:22 INFO - Running main action method: run_tests 19:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:45:22 INFO - Python 2.7.3 19:45:22 INFO - Return code: 0 19:45:22 INFO - grabbing minidump binary from tooltool 19:45:22 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')]} 19:45:22 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 0x286b410>, '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 0x286c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:45:22 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 19:45:22 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 19:45:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:45:22 INFO - Return code: 0 19:45:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:45:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:45:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:45:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:45:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:45:23 INFO - Return code: 0 19:45:23 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/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 19:45:23 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/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 19:45:23 INFO - Using env: {'DISPLAY': ':0', 19:45:23 INFO - 'HOME': '/home/cltbld', 19:45:23 INFO - 'LANG': 'en_US.UTF-8', 19:45:23 INFO - 'LANGUAGE': 'en_US:en', 19:45:23 INFO - 'LOGNAME': 'cltbld', 19:45:23 INFO - 'MAIL': '/var/mail/cltbld', 19:45:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:45:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:23 INFO - 'MOZ_NO_REMOTE': '1', 19:45:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:23 INFO - 'NO_EM_RESTART': '1', 19:45:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:23 INFO - 'PWD': '/builds/slave/test', 19:45:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:45:23 INFO - 'SHELL': '/bin/bash', 19:45:23 INFO - 'SHLVL': '1', 19:45:23 INFO - 'TERM': 'linux', 19:45:23 INFO - 'TMOUT': '86400', 19:45:23 INFO - 'USER': 'cltbld', 19:45:23 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240', 19:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:23 INFO - '_': '/tools/buildbot/bin/python'} 19:45:23 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/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 19:45:23 INFO - mozversion application_buildid: 20160401190750 19:45:23 INFO - mozversion application_changeset: d080043beed9d866ef0e5591e5c23b243d10992e 19:45:23 INFO - mozversion application_display_name: Nightly 19:45:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:45:23 INFO - mozversion application_name: Firefox 19:45:23 INFO - mozversion application_remotingname: firefox 19:45:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:45:23 INFO - mozversion application_vendor: Mozilla 19:45:23 INFO - mozversion application_version: 48.0a1 19:45:23 INFO - mozversion platform_buildid: 20160401190750 19:45:23 INFO - mozversion platform_changeset: d080043beed9d866ef0e5591e5c23b243d10992e 19:45:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:45:23 INFO - mozversion platform_version: 48.0a1 19:45:23 INFO - using testdate: 1459565123 19:45:23 INFO - actual date: 1459565123 19:45:23 INFO - starting webserver on 'localhost:60896' 19:45:23 INFO - SUITE-START | Running 2 tests 19:45:23 INFO - TEST-START | dromaeo_css 19:45:23 INFO - operating with platform_type : linux_ 19:45:23 INFO - Initialising browser for dromaeo_css test... 19:45:23 INFO - TEST-INFO | started process 10387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO8b0So/profile http://localhost:60896/getInfo.html) 19:45:27 INFO - PROCESS | 10387 | __metrics Screen width/height:1600/1200 19:45:27 INFO - PROCESS | 10387 | colorDepth:24 19:45:27 INFO - PROCESS | 10387 | Browser inner width/height: 1024/697 19:45:27 INFO - PROCESS | 10387 | __metrics 19:45:28 ERROR - PROCESS | 10387 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:45:29 INFO - TEST-INFO | 10387: exit 0 19:45:29 INFO - Browser initialized. 19:45:29 INFO - Running cycle 1/1 for dromaeo_css test... 19:45:29 INFO - TEST-INFO | started process 10468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO8b0So/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:45:41 INFO - PROCESS | 10468 | RSS: Main: 154431488 19:45:41 INFO - PROCESS | 10468 | 19:46:32 INFO - PROCESS | 10468 | 1459565192838 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] 19:48:44 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:60896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60896/tests/dromaeo/cssquery-ext.html) 19:48:45 INFO - PROCESS | 10468 | RSS: Main: 272633856 19:48:45 INFO - PROCESS | 10468 | 19:51:48 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:60896/tests/dromaeo/cssquery-ext.html (next: http://localhost:60896/tests/dromaeo/cssquery-jquery.html) 19:51:48 INFO - PROCESS | 10468 | RSS: Main: 236572672 19:51:48 INFO - PROCESS | 10468 | 19:54:50 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:60896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60896/tests/dromaeo/cssquery-mootools.html) 19:54:51 INFO - PROCESS | 10468 | RSS: Main: 235737088 19:54:51 INFO - PROCESS | 10468 | 19:57:53 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:60896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60896/tests/dromaeo/cssquery-prototype.html) 19:57:53 INFO - PROCESS | 10468 | RSS: Main: 224030720 19:57:53 INFO - PROCESS | 10468 | 20:00:56 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:60896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60896/tests/dromaeo/cssquery-yui.html) 20:00:57 INFO - PROCESS | 10468 | RSS: Main: 204660736 20:00:57 INFO - PROCESS | 10468 | 20:03:59 INFO - PROCESS | 10468 | Cycle 1(1): loaded http://localhost:60896/tests/dromaeo/cssquery-yui.html (next: http://localhost:60896/tests/dromaeo/cssquery-dojo.html) 20:03:59 INFO - PROCESS | 10468 | RSS: Main: 255213568 20:03:59 INFO - PROCESS | 10468 | 20:03:59 INFO - PROCESS | 10468 | __start_tp_report 20:03:59 INFO - PROCESS | 10468 | _x_x_mozilla_page_load 20:03:59 INFO - PROCESS | 10468 | _x_x_mozilla_page_load_details 20:03:59 INFO - PROCESS | 10468 | |i|pagename|runs| 20:03:59 INFO - PROCESS | 10468 | |0;dojo.html;2649.7085320614733;2733.9316517087072;2737.2746222251094;2747.5466548019576;2764.460930118627;4537.069900670363;4656.254999200129;4658.836940707076;4674.719516828993;4682.297655351695;4658.091672123929;4676.532346765322;4705.200115980283;4776.785044672989;4808.062427826575;4303.2684443644575;4328.675349348811;4340.348947657845;4378.124375124972;4389.144116897206;4376.256036473807;4424.734515929038;4438.400815889846;4462.419885414892;4463.040446304044;4231.978840105779;4329.307310830283;4332.935005974913;4345.413369195181;4391.297392417214;4246.766427846467;4348.108637729258;4355.324924636655;4378.299472084451;4403.251447253974;4259.595338442843;4264.104538047014;4269.466316710411;4307.418498502693;4310.504292006428;4489.3490443885785;4535.206338890681;4551.089782043605;4572.291294849304;4583.1062942726185;5009.924851127236;5017.64876458648;5019.498050194988;5029.371328583927;5041.470645582234;5020.0963826511215;5032.043911656773;5039.84880453587;5067.569256613192;5086.9745651271505;4586.564276393738;4660.974585591164;4667.276572131325;4676.789544470507;4759.262314341283;5117.8464646060675;5139.871503212449;5146.279520867081;5147.047796157723;5174.793008279702;4935.950640493549;4943.629227807929;4949.034938187019;4964.726940018261;4994.175960966472;4881.511848815161;4986.501349864984;5031.874203144877;5070.315507406527;5084.745762711849;4930.704157750546;4935.111679897653;4949.158643030693;4951.752412379366;4998.750062496861;4921.138800709861;4921.163402221631;4926.75366231687;4933.728644924564;4972.129877271463;4118.176364727066;4166.645835103989;4228.238916994909;4266.125444283976;4279.807408666617;3636.9818150909605;3642.8907132786057;3646.762960407565;3695.5380577427823;3696.9445458318146;4221.303484925014;4226.260404429213;4255.851045213464;4280.978595107067;4281.97859010703;4930.5069493050405;5017.949820501748;5042.218456139304;5113.948860511347;5135.281060651511;4251.341042138473;4262.595053469915;4277.187334406515;4281.935770963438;4301.6773741968855;4383.671224658164;4465.732056076646;4465.888352791141;4467.7319360838455;4468.419105516262;4694.319323698113;4768.666193366431;4771.260454629538;4799.328094066764;4819.518048195152;4984.077945580079;5017.698938063728;5021.271915572149;5023.572996295356;5068.721220332917;4634.559716826896;4715.717056976592;4723.6929599575915;4725.574698277172;4773.331733557374;4926.236433352836;4932.506749325183;4945.357103576512;4946.629002824874;4996.175631020987;5011.649184557046;5013.197888337849;5016.372953380827;5016.54851063406;5071.619628527801;4838.322634831196;4872.512748725099;4891.33966914462;4931.260310953242;4991.051700176955;4816.638752093537;4839.467658557626;4847.394075740533;4882.975585122052;4886.486918873609;4769.928451073168;4771.069641420028;4772.689775164603;4792.616590672807;4826.710397376169;4820.927686084781;4864.805407783649;4870.391201099863;4878.243872199815;4937.160682683881;4726.125666751662;4791.856244312677;4793.664443488922;4812.302216178565;4813 20:03:59 INFO - PROCESS | 10468 | |1;ext.html;527.8785879247775;531.2960327565976;539.948704873037;552.7650748431915;566.6401834834878;26924.461510769797;34277.31445371091;35156.94529164126;35233.647663523356;35251;37911;38232.235355292876;38256.61743382565;38274.617253827455;38410.42384364237;7588.506747061423;7770.067591888981;7786.221377862225;7789.182135875736;7791.649375778075;7638.503497272687;7769.300762931335;7769.572673502955;7773.0672319321475;7913.050433947934;7866.134725180225;7970;7973.282404583586;7974.1627129151475;7975.40184486163;7868.134505204423;7936;7946.562939038351;7948.284654381134;7955.721549745731;7827.491213071189;7937.761867143995;7944.602769861542;7948.801279968047;7951.085625153123;38695.22609547822;39070.804645976874;39136;39143;39209;3077.7691673124605;3474.8957531274104;3785.8674946376746;3809.885703428874;3872.7095467839745;29427;29759.40481190364;29799.10602681923;30447.847760761277;30947.535786963213;3446.4141096013736;3505.5793304803587;3556.875509357186;3650.707943364551;3658.506101676266;243845;246826;247575;248470;248793;42707.786461067495;43413.565864340955;43421;59356.406435935955;59823.102653460235;39874.60125398767;40085.79957100196;40326.39510407346;40403.797981009906;40416.59583404187;13033.934830325788;13221;13233.602991910258;13244.404001819941;13258.801117983237;10480.842787358195;10506.579736810441;10524.421156836448;10689;10723.731906702238;14788.408463661333;14870.702585948437;14920.253987300592;14924.477643282433;15042.774358384633;5688.914666280009;5710.828675139753;5737.770489180386;5799.3620701722775;5811.27359080115;874.6370256343673;898.308302606989;927.6428574998539;984.2716389871587;992.7915137820994;26680.59979100315;27020.324491887466;27242.72757272402;27446.725532744815;27518.724812751618;839.5969934431507;938.5870217104452;939.7697564096703;974.3763991045737;979.9951000244953;12865.4210560525;12925.289109098901;15546.222688865511;15615.921920390325;16426.75359869603;347926;352567.2689457961;353888;354883;355236;51311.74344128255;51783;51865.48134518682;51900.48099519032;51901.480985189664;854.6752234150982;1265.4938024790158;1270.8157317188957;1271.0594160321295;1279.9232046077266;25575.360615984748;26713;27464.450710986068;27519.862400687867;27713.168604941882;37222.813885930394;37683.246335072596;37750.43374349332;37800.62199377971;38843;178524.10737946228;181786;181826;182046;255176.24118794358;31334;31691.84154079307;31916;32494;32542;38373;39020.6097939017;39326;39689;40028.1994360117;32796.34407311888;32807.17982050468;32877.67122328746;33425.33149337048;33564.66435335615;32217.677823221467;32862.507062393604;32906.5064024035;33305.83347083249;33620.83189584036;33505;33707.3258534823;33819;34017.48973765445;34280.485792713625;28665.671641791047;29414.705852941195;30079.548806767478;30101.69898300989;30389.848050759603;23511.76488235096;23881.52236955286;23900.256648391816;24138.155164569154;24308.87845560761 20:03:59 INFO - PROCESS | 10468 | |2;jquery.html;337.06464560843665;352.700204825898;359.1416514530273;362.71889285803513;367.35345791407116;15660.686786264268;15880.285387157577;16021.59946001349;16264.593385165377;16314.918425407886;15067.77398339023;15380.461683841067;16568.917155414238;16636.25136868841;16649.50051498454;4928.704277743338;4994.450610432849;5038.773255203506;5057.03916255912;5077.669951453162;4892.779824907888;4957.826476073338;4996.200607902736;5012.323336349601;5040.294358789773;4972.552470277675;4984.825531106412;4997.825076122336;5005.174146265862;5006.774695138727;4981.825636102737;5169.457206993249;5185.274061631375;5196.662216955905;5199;4980.452150263468;5003.4746351633285;5007.549320561167;5010.924836127461;5013.699178049329;11119.833202501968;12071.094667899943;12071.57749478764;12072.577459788865;12081.395930203455;1806.2955447375534;2107.420459373669;2113.080809847721;2150.849440539163;2227.6992605998144;8842.602082906285;8918.152775486318;9090.2273306769;12077.852604002606;12901.806472902914;1736.748171515136;1743.8517725993306;1790.3286267649632;1850.9629807403776;1888.6033932874113;55563.72218138883;58505;58749.706251468895;58909.41090589125;60267;9207.953960230156;9360.485173315397;9518.571664274985;9582.377145485521;9686.07982241686;13036.478540858448;13103.934480327538;13115.803262951064;13127.671808204681;13143.277119758504;6893.689783959734;6903;7166.498345115792;7195.748148814766;7253.274672532704;6702.83242918931;6847;6862.588244705334;6902.137232845895;6910.585364878023;4050.797460126982;4171.541130475645;4183.97908010458;4226.429432026698;4245.91508169841;1734.7224444088886;1766.1963806468027;1792.7400526923784;1807.593291509426;1808.692522271217;867.3494878840869;882.43965082172;896.2292428511475;936.4755736787421;944.7260294514514;15448.38206471751;15662.686746265012;15677.686446271011;15913.920430398006;15940.92029539845;841.7432683031734;867.1415298854089;887.4098724348365;907.1336873285996;930.06993006993;9024.774380640405;9197.678081267257;9282.535873206312;9349.205317548085;9478.33651644392;341978;371199;379678;379862;386005;64745;68291.65854170697;69912;70122;70755.2924470759;893.6380765789866;904.5296445848122;918.5499105438421;923.8660394242931;924.0713083351324;14071.507497237548;14090;14353.210573418562;14448.277586120863;14588.927055364655;30368.696313036588;31897.521537177425;32095.197620059684;32413.51379729353;32866.34267314688;42587.3611895828;43434.348484773385;43839.78080109579;43889;44348.11303773971;7422.1835598085245;7469.327760501581;7480.738174163878;7491.662875170521;7521.962390188014;10436.747590289215;11385;11584.420778961186;11745.236559623598;12042.578509752117;8967.596458159269;10095.949520252352;10349.275550711378;10441.321314114559;10448.268621196443;10065.144462720751;10142.239332049978;10286.228532859916;10416.375017498975;10489.737756555842;10387.896121038693;10523.73690657709;10617.946910265398;10675.252732308974;10829.350238985686;7151.32062454066;7444.702211911463;7535.698572057276;7555.093388793161;7677.30904218623;9070.501122438329;9782.80434391294;10339.172866170838;10601.734956626146;10605 20:03:59 INFO - PROCESS | 10468 | |3;mootools.html;1321.5440672967823;1388.4793202549045;1448.6740483391236;1596.177968346302;1803.7474753534507;7152.499325047243;7345.632718364087;7365.926340736591;7370.410367170627;7386.372158366538;7174.96412517938;7363.742269020585;7379.55722656641;7380.483366164371;7381.88927166093;1926.1524929031182;2164.4805246740825;2201.6587428948537;2239.3282015395316;2241.1483636218213;2216.855904366219;2227.209340684058;2228.3315005498366;2230.208276061991;2233.530958498717;2136.0921608316403;2218.389942765736;2219.8002179803816;2224.399412158716;2225.5882661707556;2173.7500187478404;2176.0534167637047;2193.1556350804976;2254.8083412909923;2263.3210036989003;2206.415299945516;2226.7105276314137;2235.88820558973;2236.552689462098;2255.804423655465;7485.887711684329;7564.962175189144;7574.583397913113;7583.355414789749;7594.088709354913;4434.334849772527;4483.775811209459;4567.383403240587;4569.383133276999;4592.885177870547;2960.5263157894847;3064.417760625496;3114.314850732835;3136.7333776629016;3141.6701246369257;1022.9795404091876;1030.057497389895;1030.922680798943;1047.565260416926;1067.5622994572266;9933.255005874516;9976.201903847676;9985.350952188084;10008.14930730896;10020.448875311855;3821.617838216156;4005.118873847749;4065.7560546367313;4066.4916885389325;4078.408630748584;8082.676692932335;8266.04940431846;8349.33205343571;8353.540555269397;8359.414840961075;3847.0574709196426;4493.662975276868;4551.340055691906;4553.453585569753;4560.087982403533;3977.3238549446087;4105.58944105593;4111.424400583921;4115.238680844053;4118.91762164761;3268.7385009199206;3349.2129349602824;3357.0096821437733;3365.5624768779903;3392.71161951232;1012.6253286283975;1013.5894962540183;1025.3130402630106;1028.5114570578914;1035.4822588705647;1046.5709059285657;1213.1507944438752;1234.8950339221087;1251.7183633682348;1261.1739310751473;7132.465065120136;7140.678669459887;7165.534240274365;7189.460790440738;7212.026376439114;434.7543637844608;447.6239958434865;449.4045389858451;450.66875846252975;451.2531759937309;5455;5474.7810087596845;5586.078297081018;5596.748146333425;5646.407127251661;9028.36801423894;9360.391574547633;9360.62557497706;9379.437233765859;9397.201237894855;8773.736787896374;9108.453492790453;9151.130642588943;9157.816843663222;9181.311401644904;6815.182178138655;6889.655517224119;6900.551464154814;6938.514303998772;6958.826029349206;6495.447886929475;6584.637844918576;6617.437517810848;6639.53523253387;6647.069410282661;8032.59837008159;8112.310453611273;8137.79655508617;8179.918200818153;8329.541875196923;8177.345812335118;8419.368547359096;8507.064222935349;8524.445911015764;8549.829003420022;5424.5660347172925;5827.1841942127285;6013.278406591237;6096.847578810565;6207.193064901534;6959;6960.234374218933;6979.546329488567;6991.510594258353;7011.228764835966;6218.284897236876;6394.90407643895;6457.709403076967;6461.353864613501;6498;6091.573589848668;6100.176476175659;6192.133101365723;6203.348648391854;6327.209098862642;6555.4427873629365;6622.10601568782;6646.501512386493;6666.100076489612;6672.699728512326;6046.848828779316;6060.909086363797;6092.45167934888;6095.3904609538695;6106.3588323227195;6321.336259692666;6385.3295403983775;6394.392532709385;6396.328385519453;6413.1021656969 20:03:59 INFO - PROCESS | 10468 | |4;prototype.html;325.06543686900164;325.8126577218097;327.60196361420867;328.3810018115852;333.76803121830324;5296.735163241837;5333.413324534303;5346.465353464651;5354.14333706607;5380.488853558905;5274.4461831507715;5276.103062479378;5307;5312.6281160318795;5316.388615309231;3936.252112098706;4029.717919745619;4086.1419101988467;4142.2958097123565;4143.896402589937;4158.334666453368;4169.124483858393;4172.061286210609;4176.97911510442;4179.080602267496;4119.217348703752;4135.524414692319;4139.151473947833;4140.875773726793;4141.109661422794;3869.8645547405845;3999.460072890152;4099.200655872076;4121.402396652498;4132.938005929914;3644.671979521856;3653.7442379033478;3657.9817100914324;3660.4692319613505;3664.6518580735055;5139.58883289336;5148.4851514848215;5150.381954165524;5156.510131537498;5167.9224811627855;4803.375561177025;4805.846596816774;4815.614750819926;4817.445993710733;4821.204501257288;5610.523105536035;5617.045102332613;5623.550115990752;5630.211770352154;5635.690037047961;4037.071473561068;4045.939310910339;4047.797610119482;4050.675945924319;4053.391991201314;5716.314042314949;5905.438983296623;5906.675132867691;5910.615809972338;5911.999999999957;3982.601739825994;4018.7186896916937;4020.3366444536323;4025.1547175092974;4042.43405923171;4088.2436749200897;4091.9181616367505;4093.7134400592267;4096.938545921814;4098.282800509899;4685.273782563708;4689.413823272091;4694;4697.295405689106;4701.153792317347;5589.608727389043;5589.80435684749;5605.7197140142825;5608.9439105609235;5612.130119831432;1424.4302279088447;1443.256722787765;1443.8628330308604;1444.6677264229286;1446.096189881324;869.9913000870037;888.2228050455851;918.150710592699;960.2078285414561;963.4123184857232;4820.469748327681;4843.104025755247;4869.902601947942;4973.651844370932;4975;5905.261842269716;5918.171455996164;5918.201042859245;5924.792632257937;5935.169076329231;4996.025774973918;4998.475160108209;5034.320366750442;5035.949640503548;5036.622253331015;3095.969040309568;3151.826649534252;3164.114048066499;3167.667394923546;3172.191091271757;5507.752151153128;5508.3114610673665;5514.09017512114;5523.254360661259;5524.1989911462615;5801.158831969341;5977.850553736104;6018.729157187937;6020.578559500793;6032;5459.69971651555;5485.780568777204;5494.478024587658;5501.092319767274;5502.80740174092;5865.677387743715;5867.266591676041;5874.324452687995;5876.941230587639;5877.853053673522;5660.405657405913;5695.6330480685165;5705.3153621564015;5713.514351280188;5719.942800572107;5354.732263386893;5498.752556135064;5498.80754173602;5508.476694713996;5515.393306736336;3957.2085582882964;4051.291024070717;4053.331200352027;4057;4058.2695114879607;5836.066229403275;5866.7066646668345;5869.354371019099;5871.207387002871;5871.559633027626;5672.914906276326;5673.432656734293;5676.829695109153;5678.375378708256;5685.459881311269;5662.745176466987;5666.923284575917;5674.148877668217;5676.432356764456;5678.886422271614;5363.865903352447;5580.888382232414;5580.916286255629;5581.581381396492;5584.525315348241;5654.491095801398;5654.773809047592;5679.091345384719;5681.545476361964;5710.257666503494;5577.888442231214;5578.77684892616;5580.135079062752;5584.664920104807;5587.273654424899 20:03:59 INFO - PROCESS | 10468 | |5;yui.html;615.9322474527803;644.0371644391633;702.2275496953349;750.7597568777993;788.7160622176016;11738.941305293472;11817.35004574748;11838.112141589372;11862.228955117922;11906.583269585566;11861.466234019468;11881.405929703502;11889.167758256925;11978.880211197886;11991.460384282707;642.7172044300493;791.2878409431501;795.5862951265339;809.2797410304834;815.339574944297;809.6882700160422;814.242754238558;815.1440986963694;815.5840521334103;816.4488969945293;844.5270648436895;847.7880529867533;848.2196379331031;848.6775025490335;848.7326492154982;669.2437545573495;680.3842522517081;680.4012469027274;832.7501749475193;842.418731075559;627.0374974414298;627.554436350192;628.3402427451158;629.9748010079592;630.2059405149499;12374.56689015889;12406.62780116598;12414.068944829083;12420.875791242153;12424.689382765413;12306.507739690402;12751;12872.806907896389;12934;12984.870151298555;10056.396616202977;10069.194464442828;10163.085322320952;10324.741881452948;10358.792824143551;3355.9161020974425;3418.743594230443;3431.4509678451327;3458.1354661334667;3512.3853325667906;43242.567574324166;43600;43765.78117109426;43793.343099853526;45033.09933801305;9842.80314393708;9920.355176913477;9931.155851752683;9970.351927124859;10288.588456461808;17869.553261168574;17902.731459028124;17914.193861276275;17945.641087178185;17972.55068623295;6567.113439685581;6911.274316196727;6963.965180174168;6977.33715297046;6986.825329366705;3747.437884317374;3801.904952376213;3804.6575808177395;3847.2882516734494;3882.864099756495;2816.859157042181;2818.0418657656496;2827.3355761396056;2873.267316834194;2882.2218001139577;528.5982653183531;530.7478947499984;538.9056915039853;539.3285359727165;543.760745272087;482.32956190894686;529.68000159302;561.015398082207;595.7259660556106;601.9518438524907;7901.525908445512;8005.519668819889;8222.958885205655;8404.537750423786;8430.578471076422;569.5244470866872;570.9600327977001;576.5877397660693;588.8262962426008;593.1399470767404;3629.364861149288;3645.54430696163;3705.814709264526;3743.1765011697385;3850.2876967761053;52772;53323.20015199775;53376.466235337924;54144.45855541473;54233.1865022025;44933.32600011003;45110;45314.54685453169;45997.77001114973;47278;42771.57228427738;43407.13185736268;43489.130217395475;43524.347134793;43642.56357436448;7623.4663573549315;7687.194838554951;7715.807104822425;7725.266099720518;7811;31270;32711.345773084882;32976.835115824266;33089.66910330962;34091;38082;41307.7934610325;41542.37686434646;41781.79109104435;42368;8979.551022448983;8988.955055224682;9020.14308640678;9034.728958131267;9128.680496182602;9989.350692204984;10126.949365253127;10133.13868321201;10141.949290253502;10167.542460589144;9633;9742.366746161477;9809.509524523888;9909.30634855582;10175.542100605342;9621.326507144713;9835;9903.108720215216;9932.404055756677;10009.749756256151;9114.498702571422;9453.149216570542;9465.716028519155;9478;9500.192483638968;7745.496542724705;7909.841803163789;7998.48142745817;8228.917710823054;8326.50040997542;7934.920650793418;8122.7157049502985;8167.264946154874;8241.374493644527;8304.543250121302 20:03:59 INFO - PROCESS | 10468 | __end_tp_report 20:03:59 INFO - PROCESS | 10468 | __start_cc_report 20:03:59 INFO - PROCESS | 10468 | _x_x_mozilla_cycle_collect,1112 20:03:59 INFO - PROCESS | 10468 | __end_cc_report 20:03:59 INFO - PROCESS | 10468 | __startTimestamp1459566239800__endTimestamp 20:03:59 INFO - PROCESS | 10468 | 20:03:59 INFO - PROCESS | 10468 | ------- Summary: start ------- 20:03:59 INFO - PROCESS | 10468 | Number of tests: 6 20:03:59 INFO - PROCESS | 10468 | 20:03:59 INFO - PROCESS | 10468 | [#0] dojo.html Cycles:165 Average:4627.68 Median:4771.26 stddev:475.27 (10.0%) stddev-sans-first:450.68 20:03:59 INFO - PROCESS | 10468 | Values: 2649.7 2733.9 2737.3 2747.5 2764.5 4537.1 4656.3 4658.8 4674.7 4682.3 4658.1 4676.5 4705.2 4776.8 4808.1 4303.3 4328.7 4340.3 4378.1 4389.1 4376.3 4424.7 4438.4 4462.4 4463.0 4232.0 4329.3 4332.9 4345.4 4391.3 4246.8 4348.1 4355.3 4378.3 4403.3 4259.6 4264.1 4269.5 4307.4 4310.5 4489.3 4535.2 4551.1 4572.3 4583.1 5009.9 5017.6 5019.5 5029.4 5041.5 5020.1 5032.0 5039.8 5067.6 5087.0 4586.6 4661.0 4667.3 4676.8 4759.3 5117.8 5139.9 5146.3 5147.0 5174.8 4936.0 4943.6 4949.0 4964.7 4994.2 4881.5 4986.5 5031.9 5070.3 5084.7 4930.7 4935.1 4949.2 4951.8 4998.8 4921.1 4921.2 4926.8 4933.7 4972.1 4118.2 4166.6 4228.2 4266.1 4279.8 3637.0 3642.9 3646.8 3695.5 3696.9 4221.3 4226.3 4255.9 4281.0 4282.0 4930.5 5017.9 5042.2 5113.9 5135.3 4251.3 4262.6 4277.2 4281.9 4301.7 4383.7 4465.7 4465.9 4467.7 4468.4 4694.3 4768.7 4771.3 4799.3 4819.5 4984.1 5017.7 5021.3 5023.6 5068.7 4634.6 4715.7 4723.7 4725.6 4773.3 4926.2 4932.5 4945.4 4946.6 4996.2 5011.6 5013.2 5016.4 5016.5 5071.6 4838.3 4872.5 4891.3 4931.3 4991.1 4816.6 4839.5 4847.4 4883.0 4886.5 4769.9 4771.1 4772.7 4792.6 4826.7 4820.9 4864.8 4870.4 4878.2 4937.2 4726.1 4791.9 4793.7 4812.3 4813.0 20:03:59 INFO - PROCESS | 10468 | 20:03:59 INFO - PROCESS | 10468 | [#1] ext.html Cycles:180 Average:41790.50 Median:354385.50 stddev:71922.56 (20.3%) stddev-sans-first:72057.60 20:03:59 INFO - PROCESS | 10468 | Values: 527.9 531.3 539.9 552.8 566.6 26924.5 34277.3 35156.9 35233.6 35251.0 37911.0 38232.2 38256.6 38274.6 38410.4 7588.5 7770.1 7786.2 7789.2 7791.6 7638.5 7769.3 7769.6 7773.1 7913.1 7866.1 7970.0 7973.3 7974.2 7975.4 7868.1 7936.0 7946.6 7948.3 7955.7 7827.5 7937.8 7944.6 7948.8 7951.1 38695.2 39070.8 39136.0 39143.0 39209.0 3077.8 3474.9 3785.9 3809.9 3872.7 29427.0 29759.4 29799.1 30447.8 30947.5 3446.4 3505.6 3556.9 3650.7 3658.5 243845.0 246826.0 247575.0 248470.0 248793.0 42707.8 43413.6 43421.0 59356.4 59823.1 39874.6 40085.8 40326.4 40403.8 40416.6 13033.9 13221.0 13233.6 13244.4 13258.8 10480.8 10506.6 10524.4 10689.0 10723.7 14788.4 14870.7 14920.3 14924.5 15042.8 5688.9 5710.8 5737.8 5799.4 5811.3 874.6 898.3 927.6 984.3 992.8 26680.6 27020.3 27242.7 27446.7 27518.7 839.6 938.6 939.8 974.4 980.0 12865.4 12925.3 15546.2 15615.9 16426.8 347926.0 352567.3 353888.0 354883.0 355236.0 51311.7 51783.0 51865.5 51900.5 51901.5 854.7 1265.5 1270.8 1271.1 1279.9 25575.4 26713.0 27464.5 27519.9 27713.2 37222.8 37683.2 37750.4 37800.6 38843.0 178524.1 181786.0 181826.0 182046.0 255176.2 31334.0 31691.8 31916.0 32494.0 32542.0 38373.0 39020.6 39326.0 39689.0 40028.2 32796.3 32807.2 32877.7 33425.3 33564.7 32217.7 32862.5 32906.5 33305.8 33620.8 33505.0 33707.3 33819.0 34017.5 34280.5 28665.7 29414.7 30079.5 30101.7 30389.8 23511.8 23881.5 23900.3 24138.2 24308.9 20:03:59 INFO - PROCESS | 10468 | 20:03:59 INFO - PROCESS | 10468 | [#2] jquery.html Cycles:180 Average:22501.79 Median:43637.06 stddev:61126.50 (140.1%) stddev-sans-first:61275.32 20:03:59 INFO - PROCESS | 10468 | Values: 337.1 352.7 359.1 362.7 367.4 15660.7 15880.3 16021.6 16264.6 16314.9 15067.8 15380.5 16568.9 16636.3 16649.5 4928.7 4994.5 5038.8 5057.0 5077.7 4892.8 4957.8 4996.2 5012.3 5040.3 4972.6 4984.8 4997.8 5005.2 5006.8 4981.8 5169.5 5185.3 5196.7 5199.0 4980.5 5003.5 5007.5 5010.9 5013.7 11119.8 12071.1 12071.6 12072.6 12081.4 1806.3 2107.4 2113.1 2150.8 2227.7 8842.6 8918.2 9090.2 12077.9 12901.8 1736.7 1743.9 1790.3 1851.0 1888.6 55563.7 58505.0 58749.7 58909.4 60267.0 9208.0 9360.5 9518.6 9582.4 9686.1 13036.5 13103.9 13115.8 13127.7 13143.3 6893.7 6903.0 7166.5 7195.7 7253.3 6702.8 6847.0 6862.6 6902.1 6910.6 4050.8 4171.5 4184.0 4226.4 4245.9 1734.7 1766.2 1792.7 1807.6 1808.7 867.3 882.4 896.2 936.5 944.7 15448.4 15662.7 15677.7 15913.9 15940.9 841.7 867.1 887.4 907.1 930.1 9024.8 9197.7 9282.5 9349.2 9478.3 341978.0 371199.0 379678.0 379862.0 386005.0 64745.0 68291.7 69912.0 70122.0 70755.3 893.6 904.5 918.5 923.9 924.1 14071.5 14090.0 14353.2 14448.3 14588.9 30368.7 31897.5 32095.2 32413.5 32866.3 42587.4 43434.3 43839.8 43889.0 44348.1 7422.2 7469.3 7480.7 7491.7 7522.0 10436.7 11385.0 11584.4 11745.2 12042.6 8967.6 10095.9 10349.3 10441.3 10448.3 10065.1 10142.2 10286.2 10416.4 10489.7 10387.9 10523.7 10617.9 10675.3 10829.4 7151.3 7444.7 7535.7 7555.1 7677.3 9070.5 9782.8 10339.2 10601.7 10605.0 20:03:59 INFO - PROCESS | 10468 | 20:03:59 INFO - PROCESS | 10468 | [#3] mootools.html Cycles:180 Average:5165.69 Median:6053.88 stddev:2700.24 (44.6%) stddev-sans-first:2692.36 20:03:59 INFO - PROCESS | 10468 | Values: 1321.5 1388.5 1448.7 1596.2 1803.7 7152.5 7345.6 7365.9 7370.4 7386.4 7175.0 7363.7 7379.6 7380.5 7381.9 1926.2 2164.5 2201.7 2239.3 2241.1 2216.9 2227.2 2228.3 2230.2 2233.5 2136.1 2218.4 2219.8 2224.4 2225.6 2173.8 2176.1 2193.2 2254.8 2263.3 2206.4 2226.7 2235.9 2236.6 2255.8 7485.9 7565.0 7574.6 7583.4 7594.1 4434.3 4483.8 4567.4 4569.4 4592.9 2960.5 3064.4 3114.3 3136.7 3141.7 1023.0 1030.1 1030.9 1047.6 1067.6 9933.3 9976.2 9985.4 10008.1 10020.4 3821.6 4005.1 4065.8 4066.5 4078.4 8082.7 8266.0 8349.3 8353.5 8359.4 3847.1 4493.7 4551.3 4553.5 4560.1 3977.3 4105.6 4111.4 4115.2 4118.9 3268.7 3349.2 3357.0 3365.6 3392.7 1012.6 1013.6 1025.3 1028.5 1035.5 1046.6 1213.2 1234.9 1251.7 1261.2 7132.5 7140.7 7165.5 7189.5 7212.0 434.8 447.6 449.4 450.7 451.3 5455.0 5474.8 5586.1 5596.7 5646.4 9028.4 9360.4 9360.6 9379.4 9397.2 8773.7 9108.5 9151.1 9157.8 9181.3 6815.2 6889.7 6900.6 6938.5 6958.8 6495.4 6584.6 6617.4 6639.5 6647.1 8032.6 8112.3 8137.8 8179.9 8329.5 8177.3 8419.4 8507.1 8524.4 8549.8 5424.6 5827.2 6013.3 6096.8 6207.2 6959.0 6960.2 6979.5 6991.5 7011.2 6218.3 6394.9 6457.7 6461.4 6498.0 6091.6 6100.2 6192.1 6203.3 6327.2 6555.4 6622.1 6646.5 6666.1 6672.7 6046.8 6060.9 6092.5 6095.4 6106.4 6321.3 6385.3 6394.4 6396.3 6413.1 20:03:59 INFO - PROCESS | 10468 | 20:03:59 INFO - PROCESS | 10468 | [#4] prototype.html Cycles:180 Average:4676.87 Median:5324.90 stddev:1377.09 (25.9%) stddev-sans-first:1341.65 20:03:59 INFO - PROCESS | 10468 | Values: 325.1 325.8 327.6 328.4 333.8 5296.7 5333.4 5346.5 5354.1 5380.5 5274.4 5276.1 5307.0 5312.6 5316.4 3936.3 4029.7 4086.1 4142.3 4143.9 4158.3 4169.1 4172.1 4177.0 4179.1 4119.2 4135.5 4139.2 4140.9 4141.1 3869.9 3999.5 4099.2 4121.4 4132.9 3644.7 3653.7 3658.0 3660.5 3664.7 5139.6 5148.5 5150.4 5156.5 5167.9 4803.4 4805.8 4815.6 4817.4 4821.2 5610.5 5617.0 5623.6 5630.2 5635.7 4037.1 4045.9 4047.8 4050.7 4053.4 5716.3 5905.4 5906.7 5910.6 5912.0 3982.6 4018.7 4020.3 4025.2 4042.4 4088.2 4091.9 4093.7 4096.9 4098.3 4685.3 4689.4 4694.0 4697.3 4701.2 5589.6 5589.8 5605.7 5608.9 5612.1 1424.4 1443.3 1443.9 1444.7 1446.1 870.0 888.2 918.2 960.2 963.4 4820.5 4843.1 4869.9 4973.7 4975.0 5905.3 5918.2 5918.2 5924.8 5935.2 4996.0 4998.5 5034.3 5035.9 5036.6 3096.0 3151.8 3164.1 3167.7 3172.2 5507.8 5508.3 5514.1 5523.3 5524.2 5801.2 5977.9 6018.7 6020.6 6032.0 5459.7 5485.8 5494.5 5501.1 5502.8 5865.7 5867.3 5874.3 5876.9 5877.9 5660.4 5695.6 5705.3 5713.5 5719.9 5354.7 5498.8 5498.8 5508.5 5515.4 3957.2 4051.3 4053.3 4057.0 4058.3 5836.1 5866.7 5869.4 5871.2 5871.6 5672.9 5673.4 5676.8 5678.4 5685.5 5662.7 5666.9 5674.1 5676.4 5678.9 5363.9 5580.9 5580.9 5581.6 5584.5 5654.5 5654.8 5679.1 5681.5 5710.3 5577.9 5578.8 5580.1 5584.7 5587.3 20:03:59 INFO - PROCESS | 10468 | 20:03:59 INFO - PROCESS | 10468 | [#5] yui.html Cycles:180 Average:12629.36 Median:27341.89 stddev:14702.48 (53.8%) stddev-sans-first:14716.05 20:03:59 INFO - PROCESS | 10468 | Values: 615.9 644.0 702.2 750.8 788.7 11738.9 11817.4 11838.1 11862.2 11906.6 11861.5 11881.4 11889.2 11978.9 11991.5 642.7 791.3 795.6 809.3 815.3 809.7 814.2 815.1 815.6 816.4 844.5 847.8 848.2 848.7 848.7 669.2 680.4 680.4 832.8 842.4 627.0 627.6 628.3 630.0 630.2 12374.6 12406.6 12414.1 12420.9 12424.7 12306.5 12751.0 12872.8 12934.0 12984.9 10056.4 10069.2 10163.1 10324.7 10358.8 3355.9 3418.7 3431.5 3458.1 3512.4 43242.6 43600.0 43765.8 43793.3 45033.1 9842.8 9920.4 9931.2 9970.4 10288.6 17869.6 17902.7 17914.2 17945.6 17972.6 6567.1 6911.3 6964.0 6977.3 6986.8 3747.4 3801.9 3804.7 3847.3 3882.9 2816.9 2818.0 2827.3 2873.3 2882.2 528.6 530.7 538.9 539.3 543.8 482.3 529.7 561.0 595.7 602.0 7901.5 8005.5 8223.0 8404.5 8430.6 569.5 571.0 576.6 588.8 593.1 3629.4 3645.5 3705.8 3743.2 3850.3 52772.0 53323.2 53376.5 54144.5 54233.2 44933.3 45110.0 45314.5 45997.8 47278.0 42771.6 43407.1 43489.1 43524.3 43642.6 7623.5 7687.2 7715.8 7725.3 7811.0 31270.0 32711.3 32976.8 33089.7 34091.0 38082.0 41307.8 41542.4 41781.8 42368.0 8979.6 8989.0 9020.1 9034.7 9128.7 9989.4 10126.9 10133.1 10141.9 10167.5 9633.0 9742.4 9809.5 9909.3 10175.5 9621.3 9835.0 9903.1 9932.4 10009.7 9114.5 9453.1 9465.7 9478.0 9500.2 7745.5 7909.8 7998.5 8228.9 8326.5 7934.9 8122.7 8167.3 8241.4 8304.5 20:03:59 INFO - PROCESS | 10468 | -------- Summary: end -------- 20:03:59 INFO - PROCESS | 10468 | 20:04:00 INFO - TEST-INFO | 10468: exit 0 20:04:00 INFO - TEST-OK | dromaeo_css | took 1117215ms 20:04:00 INFO - TEST-START | kraken 20:04:00 INFO - operating with platform_type : linux_ 20:04:00 INFO - Initialising browser for kraken test... 20:04:00 INFO - TEST-INFO | started process 10646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb8ISXo/profile http://localhost:60896/getInfo.html) 20:04:05 INFO - PROCESS | 10646 | __metrics Screen width/height:1600/1200 20:04:05 INFO - PROCESS | 10646 | colorDepth:24 20:04:05 INFO - PROCESS | 10646 | Browser inner width/height: 1024/697 20:04:05 INFO - PROCESS | 10646 | __metrics 20:04:06 ERROR - PROCESS | 10646 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:04:07 INFO - TEST-INFO | 10646: exit 0 20:04:07 INFO - Browser initialized. 20:04:07 INFO - Running cycle 1/1 for kraken test... 20:04:07 INFO - TEST-INFO | started process 10728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb8ISXo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:18 INFO - PROCESS | 10728 | RSS: Main: 154525696 20:04:18 INFO - PROCESS | 10728 | 20:04:21 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60896/tests/kraken/driver.html?testName=audio-beat-detection) 20:04:22 INFO - PROCESS | 10728 | RSS: Main: 195514368 20:04:22 INFO - PROCESS | 10728 | 20:04:24 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60896/tests/kraken/driver.html?testName=audio-dft) 20:04:25 INFO - PROCESS | 10728 | RSS: Main: 185892864 20:04:25 INFO - PROCESS | 10728 | 20:04:28 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60896/tests/kraken/driver.html?testName=audio-fft) 20:04:29 INFO - PROCESS | 10728 | RSS: Main: 172171264 20:04:29 INFO - PROCESS | 10728 | 20:04:31 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60896/tests/kraken/driver.html?testName=audio-oscillator) 20:04:31 INFO - PROCESS | 10728 | RSS: Main: 172273664 20:04:31 INFO - PROCESS | 10728 | 20:04:34 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60896/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:04:34 INFO - PROCESS | 10728 | RSS: Main: 173801472 20:04:34 INFO - PROCESS | 10728 | 20:04:37 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60896/tests/kraken/driver.html?testName=imaging-darkroom) 20:04:38 INFO - PROCESS | 10728 | RSS: Main: 174153728 20:04:38 INFO - PROCESS | 10728 | 20:04:41 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60896/tests/kraken/driver.html?testName=imaging-desaturate) 20:04:42 INFO - PROCESS | 10728 | RSS: Main: 174698496 20:04:42 INFO - PROCESS | 10728 | 20:04:45 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60896/tests/kraken/driver.html?testName=json-parse-financial) 20:04:45 INFO - PROCESS | 10728 | RSS: Main: 174989312 20:04:45 INFO - PROCESS | 10728 | 20:04:47 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60896/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:04:48 INFO - PROCESS | 10728 | RSS: Main: 184127488 20:04:48 INFO - PROCESS | 10728 | 20:04:49 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60896/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:04:50 INFO - PROCESS | 10728 | RSS: Main: 183062528 20:04:50 INFO - PROCESS | 10728 | 20:04:52 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60896/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:04:53 INFO - PROCESS | 10728 | RSS: Main: 196714496 20:04:53 INFO - PROCESS | 10728 | 20:04:55 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:04:56 INFO - PROCESS | 10728 | RSS: Main: 200712192 20:04:56 INFO - PROCESS | 10728 | 20:04:58 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:04:59 INFO - PROCESS | 10728 | RSS: Main: 199786496 20:04:59 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | Cycle 1(1): loaded http://localhost:60896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60896/tests/kraken/driver.html?testName=ai-astar) 20:05:01 INFO - PROCESS | 10728 | RSS: Main: 262606848 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | __start_tp_report 20:05:01 INFO - PROCESS | 10728 | _x_x_mozilla_page_load 20:05:01 INFO - PROCESS | 10728 | _x_x_mozilla_page_load_details 20:05:01 INFO - PROCESS | 10728 | |i|pagename|runs| 20:05:01 INFO - PROCESS | 10728 | |0;ai-astar;111;115;108;114;117;112;102;113;115;116 20:05:01 INFO - PROCESS | 10728 | |1;audio-beat-detection;156;131;156;170;132;162;158;132;180;133 20:05:01 INFO - PROCESS | 10728 | |2;audio-dft;160;161;161;161;161;162;162;161;161;161 20:05:01 INFO - PROCESS | 10728 | |3;audio-fft;75;78;106;98;74;73;75;130;100;74 20:05:01 INFO - PROCESS | 10728 | |4;audio-oscillator;95;94;150;95;94;95;142;96;94;141 20:05:01 INFO - PROCESS | 10728 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;116 20:05:01 INFO - PROCESS | 10728 | |6;imaging-darkroom;147;148;148;148;146;148;147;147;147;146 20:05:01 INFO - PROCESS | 10728 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;96 20:05:01 INFO - PROCESS | 10728 | |8;json-parse-financial;66;66;67;65;66;66;65;74;63;64 20:05:01 INFO - PROCESS | 10728 | |9;json-stringify-tinderbox;63;63;63;63;64;64;64;63;63;64 20:05:01 INFO - PROCESS | 10728 | |10;stanford-crypto-aes;82;83;83;84;84;82;84;83;83;84 20:05:01 INFO - PROCESS | 10728 | |11;stanford-crypto-ccm;118;125;118;116;119;118;130;124;126;126 20:05:01 INFO - PROCESS | 10728 | |12;stanford-crypto-pbkdf2;146;130;143;142;144;136;143;144;135;144 20:05:01 INFO - PROCESS | 10728 | |13;stanford-crypto-sha256-iterative;70;71;69;73;69;68;69;71;71;67 20:05:01 INFO - PROCESS | 10728 | __end_tp_report 20:05:01 INFO - PROCESS | 10728 | __start_cc_report 20:05:01 INFO - PROCESS | 10728 | _x_x_mozilla_cycle_collect,1152 20:05:01 INFO - PROCESS | 10728 | __end_cc_report 20:05:01 INFO - PROCESS | 10728 | __startTimestamp1459566301589__endTimestamp 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | ------- Summary: start ------- 20:05:01 INFO - PROCESS | 10728 | Number of tests: 14 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#0] ai-astar Cycles:10 Average:112.30 Median:114.50 stddev:4.47 (3.9%) stddev-sans-first:4.72 20:05:01 INFO - PROCESS | 10728 | Values: 111.0 115.0 108.0 114.0 117.0 112.0 102.0 113.0 115.0 116.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:157.00 stddev:17.85 (11.4%) stddev-sans-first:18.84 20:05:01 INFO - PROCESS | 10728 | Values: 156.0 131.0 156.0 170.0 132.0 162.0 158.0 132.0 180.0 133.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 20:05:01 INFO - PROCESS | 10728 | Values: 160.0 161.0 161.0 161.0 161.0 162.0 162.0 161.0 161.0 161.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#3] audio-fft Cycles:10 Average:88.30 Median:74.50 stddev:19.40 (26.0%) stddev-sans-first:19.97 20:05:01 INFO - PROCESS | 10728 | Values: 75.0 78.0 106.0 98.0 74.0 73.0 75.0 130.0 100.0 74.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:94.50 stddev:24.09 (25.5%) stddev-sans-first:24.96 20:05:01 INFO - PROCESS | 10728 | Values: 95.0 94.0 150.0 95.0 94.0 95.0 142.0 96.0 94.0 141.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:05:01 INFO - PROCESS | 10728 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 20:05:01 INFO - PROCESS | 10728 | Values: 147.0 148.0 148.0 148.0 146.0 148.0 147.0 147.0 147.0 146.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:05:01 INFO - PROCESS | 10728 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:2.97 (4.5%) stddev-sans-first:3.15 20:05:01 INFO - PROCESS | 10728 | Values: 66.0 66.0 67.0 65.0 66.0 66.0 65.0 74.0 63.0 64.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 20:05:01 INFO - PROCESS | 10728 | Values: 63.0 63.0 63.0 63.0 64.0 64.0 64.0 63.0 63.0 64.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:0.79 (0.9%) stddev-sans-first:0.71 20:05:01 INFO - PROCESS | 10728 | Values: 82.0 83.0 83.0 84.0 84.0 82.0 84.0 83.0 83.0 84.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:124.50 stddev:4.74 (3.8%) stddev-sans-first:4.80 20:05:01 INFO - PROCESS | 10728 | Values: 118.0 125.0 118.0 116.0 119.0 118.0 130.0 124.0 126.0 126.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:143.50 stddev:5.19 (3.6%) stddev-sans-first:5.13 20:05:01 INFO - PROCESS | 10728 | Values: 146.0 130.0 143.0 142.0 144.0 136.0 143.0 144.0 135.0 144.0 20:05:01 INFO - PROCESS | 10728 | 20:05:01 INFO - PROCESS | 10728 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.50 stddev:1.75 (2.5%) stddev-sans-first:1.86 20:05:01 INFO - PROCESS | 10728 | Values: 70.0 71.0 69.0 73.0 69.0 68.0 69.0 71.0 71.0 67.0 20:05:01 INFO - PROCESS | 10728 | -------- Summary: end -------- 20:05:01 INFO - PROCESS | 10728 | 20:05:02 INFO - TEST-INFO | 10728: exit 0 20:05:02 INFO - TEST-OK | kraken | took 62016ms 20:05:02 INFO - SUITE-END | took 1179s 20:05:02 INFO - Completed test suite (00:19:39) 20:05:02 INFO - javascript benchmark 20:05:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2649.7085320614733, 2733.9316517087072, 2737.2746222251094, 2747.5466548019576, 2764.460930118627, 4537.069900670363, 4656.254999200129, 4658.836940707076, 4674.719516828993, 4682.297655351695, 4658.091672123929, 4676.532346765322, 4705.200115980283, 4776.785044672989, 4808.062427826575, 4303.2684443644575, 4328.675349348811, 4340.348947657845, 4378.124375124972, 4389.144116897206, 4376.256036473807, 4424.734515929038, 4438.400815889846, 4462.419885414892, 4463.040446304044, 4231.978840105779, 4329.307310830283, 4332.935005974913, 4345.413369195181, 4391.297392417214, 4246.766427846467, 4348.108637729258, 4355.324924636655, 4378.299472084451, 4403.251447253974, 4259.595338442843, 4264.104538047014, 4269.466316710411, 4307.418498502693, 4310.504292006428, 4489.3490443885785, 4535.206338890681, 4551.089782043605, 4572.291294849304, 4583.1062942726185, 5009.924851127236, 5017.64876458648, 5019.498050194988, 5029.371328583927, 5041.470645582234, 5020.0963826511215, 5032.043911656773, 5039.84880453587, 5067.569256613192, 5086.9745651271505, 4586.564276393738, 4660.974585591164, 4667.276572131325, 4676.789544470507, 4759.262314341283, 5117.8464646060675, 5139.871503212449, 5146.279520867081, 5147.047796157723, 5174.793008279702, 4935.950640493549, 4943.629227807929, 4949.034938187019, 4964.726940018261, 4994.175960966472, 4881.511848815161, 4986.501349864984, 5031.874203144877, 5070.315507406527, 5084.745762711849, 4930.704157750546, 4935.111679897653, 4949.158643030693, 4951.752412379366, 4998.750062496861, 4921.138800709861, 4921.163402221631, 4926.75366231687, 4933.728644924564, 4972.129877271463, 4118.176364727066, 4166.645835103989, 4228.238916994909, 4266.125444283976, 4279.807408666617, 3636.9818150909605, 3642.8907132786057, 3646.762960407565, 3695.5380577427823, 3696.9445458318146, 4221.303484925014, 4226.260404429213, 4255.851045213464, 4280.978595107067, 4281.97859010703, 4930.5069493050405, 5017.949820501748, 5042.218456139304, 5113.948860511347, 5135.281060651511, 4251.341042138473, 4262.595053469915, 4277.187334406515, 4281.935770963438, 4301.6773741968855, 4383.671224658164, 4465.732056076646, 4465.888352791141, 4467.7319360838455, 4468.419105516262, 4694.319323698113, 4768.666193366431, 4771.260454629538, 4799.328094066764, 4819.518048195152, 4984.077945580079, 5017.698938063728, 5021.271915572149, 5023.572996295356, 5068.721220332917, 4634.559716826896, 4715.717056976592, 4723.6929599575915, 4725.574698277172, 4773.331733557374, 4926.236433352836, 4932.506749325183, 4945.357103576512, 4946.629002824874, 4996.175631020987, 5011.649184557046, 5013.197888337849, 5016.372953380827, 5016.54851063406, 5071.619628527801, 4838.322634831196, 4872.512748725099, 4891.33966914462, 4931.260310953242, 4991.051700176955, 4816.638752093537, 4839.467658557626, 4847.394075740533, 4882.975585122052, 4886.486918873609, 4769.928451073168, 4771.069641420028, 4772.689775164603, 4792.616590672807, 4826.710397376169, 4820.927686084781, 4864.805407783649, 4870.391201099863, 4878.243872199815, 4937.160682683881, 4726.125666751662, 4791.856244312677, 4793.664443488922, 4812.302216178565, 4813.0], "unit": "score", "name": "dojo.html", "value": 4598.621315594773}, {"lowerIsBetter": false, "replicates": [527.8785879247775, 531.2960327565976, 539.948704873037, 552.7650748431915, 566.6401834834878, 26924.461510769797, 34277.31445371091, 35156.94529164126, 35233.647663523356, 35251.0, 37911.0, 38232.235355292876, 38256.61743382565, 38274.617253827455, 38410.42384364237, 7588.506747061423, 7770.067591888981, 7786.221377862225, 7789.182135875736, 7791.649375778075, 7638.503497272687, 7769.300762931335, 7769.572673502955, 7773.0672319321475, 7913.050433947934, 7866.134725180225, 7970.0, 7973.282404583586, 7974.1627129151475, 7975.40184486163, 7868.134505204423, 7936.0, 7946.562939038351, 7948.284654381134, 7955.721549745731, 7827.491213071189, 7937.761867143995, 7944.602769861542, 7948.801279968047, 7951.085625153123, 38695.22609547822, 39070.804645976874, 39136.0, 39143.0, 39209.0, 3077.7691673124605, 3474.8957531274104, 3785.8674946376746, 3809.885703428874, 3872.7095467839745, 29427.0, 29759.40481190364, 29799.10602681923, 30447.847760761277, 30947.535786963213, 3446.4141096013736, 3505.5793304803587, 3556.875509357186, 3650.707943364551, 3658.506101676266, 243845.0, 246826.0, 247575.0, 248470.0, 248793.0, 42707.786461067495, 43413.565864340955, 43421.0, 59356.406435935955, 59823.102653460235, 39874.60125398767, 40085.79957100196, 40326.39510407346, 40403.797981009906, 40416.59583404187, 13033.934830325788, 13221.0, 13233.602991910258, 13244.404001819941, 13258.801117983237, 10480.842787358195, 10506.579736810441, 10524.421156836448, 10689.0, 10723.731906702238, 14788.408463661333, 14870.702585948437, 14920.253987300592, 14924.477643282433, 15042.774358384633, 5688.914666280009, 5710.828675139753, 5737.770489180386, 5799.3620701722775, 5811.27359080115, 874.6370256343673, 898.308302606989, 927.6428574998539, 984.2716389871587, 992.7915137820994, 26680.59979100315, 27020.324491887466, 27242.72757272402, 27446.725532744815, 27518.724812751618, 839.5969934431507, 938.5870217104452, 939.7697564096703, 974.3763991045737, 979.9951000244953, 12865.4210560525, 12925.289109098901, 15546.222688865511, 15615.921920390325, 16426.75359869603, 347926.0, 352567.2689457961, 353888.0, 354883.0, 355236.0, 51311.74344128255, 51783.0, 51865.48134518682, 51900.48099519032, 51901.480985189664, 854.6752234150982, 1265.4938024790158, 1270.8157317188957, 1271.0594160321295, 1279.9232046077266, 25575.360615984748, 26713.0, 27464.450710986068, 27519.862400687867, 27713.168604941882, 37222.813885930394, 37683.246335072596, 37750.43374349332, 37800.62199377971, 38843.0, 178524.10737946228, 181786.0, 181826.0, 182046.0, 255176.24118794358, 31334.0, 31691.84154079307, 31916.0, 32494.0, 32542.0, 38373.0, 39020.6097939017, 39326.0, 39689.0, 40028.1994360117, 32796.34407311888, 32807.17982050468, 32877.67122328746, 33425.33149337048, 33564.66435335615, 32217.677823221467, 32862.507062393604, 32906.5064024035, 33305.83347083249, 33620.83189584036, 33505.0, 33707.3258534823, 33819.0, 34017.48973765445, 34280.485792713625, 28665.671641791047, 29414.705852941195, 30079.548806767478, 30101.69898300989, 30389.848050759603, 23511.76488235096, 23881.52236955286, 23900.256648391816, 24138.155164569154, 24308.87845560761], "unit": "score", "name": "ext.html", "value": 16651.534981721226}, {"lowerIsBetter": false, "replicates": [337.06464560843665, 352.700204825898, 359.1416514530273, 362.71889285803513, 367.35345791407116, 15660.686786264268, 15880.285387157577, 16021.59946001349, 16264.593385165377, 16314.918425407886, 15067.77398339023, 15380.461683841067, 16568.917155414238, 16636.25136868841, 16649.50051498454, 4928.704277743338, 4994.450610432849, 5038.773255203506, 5057.03916255912, 5077.669951453162, 4892.779824907888, 4957.826476073338, 4996.200607902736, 5012.323336349601, 5040.294358789773, 4972.552470277675, 4984.825531106412, 4997.825076122336, 5005.174146265862, 5006.774695138727, 4981.825636102737, 5169.457206993249, 5185.274061631375, 5196.662216955905, 5199.0, 4980.452150263468, 5003.4746351633285, 5007.549320561167, 5010.924836127461, 5013.699178049329, 11119.833202501968, 12071.094667899943, 12071.57749478764, 12072.577459788865, 12081.395930203455, 1806.2955447375534, 2107.420459373669, 2113.080809847721, 2150.849440539163, 2227.6992605998144, 8842.602082906285, 8918.152775486318, 9090.2273306769, 12077.852604002606, 12901.806472902914, 1736.748171515136, 1743.8517725993306, 1790.3286267649632, 1850.9629807403776, 1888.6033932874113, 55563.72218138883, 58505.0, 58749.706251468895, 58909.41090589125, 60267.0, 9207.953960230156, 9360.485173315397, 9518.571664274985, 9582.377145485521, 9686.07982241686, 13036.478540858448, 13103.934480327538, 13115.803262951064, 13127.671808204681, 13143.277119758504, 6893.689783959734, 6903.0, 7166.498345115792, 7195.748148814766, 7253.274672532704, 6702.83242918931, 6847.0, 6862.588244705334, 6902.137232845895, 6910.585364878023, 4050.797460126982, 4171.541130475645, 4183.97908010458, 4226.429432026698, 4245.91508169841, 1734.7224444088886, 1766.1963806468027, 1792.7400526923784, 1807.593291509426, 1808.692522271217, 867.3494878840869, 882.43965082172, 896.2292428511475, 936.4755736787421, 944.7260294514514, 15448.38206471751, 15662.686746265012, 15677.686446271011, 15913.920430398006, 15940.92029539845, 841.7432683031734, 867.1415298854089, 887.4098724348365, 907.1336873285996, 930.06993006993, 9024.774380640405, 9197.678081267257, 9282.535873206312, 9349.205317548085, 9478.33651644392, 341978.0, 371199.0, 379678.0, 379862.0, 386005.0, 64745.0, 68291.65854170697, 69912.0, 70122.0, 70755.2924470759, 893.6380765789866, 904.5296445848122, 918.5499105438421, 923.8660394242931, 924.0713083351324, 14071.507497237548, 14090.0, 14353.210573418562, 14448.277586120863, 14588.927055364655, 30368.696313036588, 31897.521537177425, 32095.197620059684, 32413.51379729353, 32866.34267314688, 42587.3611895828, 43434.348484773385, 43839.78080109579, 43889.0, 44348.11303773971, 7422.1835598085245, 7469.327760501581, 7480.738174163878, 7491.662875170521, 7521.962390188014, 10436.747590289215, 11385.0, 11584.420778961186, 11745.236559623598, 12042.578509752117, 8967.596458159269, 10095.949520252352, 10349.275550711378, 10441.321314114559, 10448.268621196443, 10065.144462720751, 10142.239332049978, 10286.228532859916, 10416.375017498975, 10489.737756555842, 10387.896121038693, 10523.73690657709, 10617.946910265398, 10675.252732308974, 10829.350238985686, 7151.32062454066, 7444.702211911463, 7535.698572057276, 7555.093388793161, 7677.30904218623, 9070.501122438329, 9782.80434391294, 10339.172866170838, 10601.734956626146, 10605.0], "unit": "score", "name": "jquery.html", "value": 7811.629351675962}, {"lowerIsBetter": false, "replicates": [1321.5440672967823, 1388.4793202549045, 1448.6740483391236, 1596.177968346302, 1803.7474753534507, 7152.499325047243, 7345.632718364087, 7365.926340736591, 7370.410367170627, 7386.372158366538, 7174.96412517938, 7363.742269020585, 7379.55722656641, 7380.483366164371, 7381.88927166093, 1926.1524929031182, 2164.4805246740825, 2201.6587428948537, 2239.3282015395316, 2241.1483636218213, 2216.855904366219, 2227.209340684058, 2228.3315005498366, 2230.208276061991, 2233.530958498717, 2136.0921608316403, 2218.389942765736, 2219.8002179803816, 2224.399412158716, 2225.5882661707556, 2173.7500187478404, 2176.0534167637047, 2193.1556350804976, 2254.8083412909923, 2263.3210036989003, 2206.415299945516, 2226.7105276314137, 2235.88820558973, 2236.552689462098, 2255.804423655465, 7485.887711684329, 7564.962175189144, 7574.583397913113, 7583.355414789749, 7594.088709354913, 4434.334849772527, 4483.775811209459, 4567.383403240587, 4569.383133276999, 4592.885177870547, 2960.5263157894847, 3064.417760625496, 3114.314850732835, 3136.7333776629016, 3141.6701246369257, 1022.9795404091876, 1030.057497389895, 1030.922680798943, 1047.565260416926, 1067.5622994572266, 9933.255005874516, 9976.201903847676, 9985.350952188084, 10008.14930730896, 10020.448875311855, 3821.617838216156, 4005.118873847749, 4065.7560546367313, 4066.4916885389325, 4078.408630748584, 8082.676692932335, 8266.04940431846, 8349.33205343571, 8353.540555269397, 8359.414840961075, 3847.0574709196426, 4493.662975276868, 4551.340055691906, 4553.453585569753, 4560.087982403533, 3977.3238549446087, 4105.58944105593, 4111.424400583921, 4115.238680844053, 4118.91762164761, 3268.7385009199206, 3349.2129349602824, 3357.0096821437733, 3365.5624768779903, 3392.71161951232, 1012.6253286283975, 1013.5894962540183, 1025.3130402630106, 1028.5114570578914, 1035.4822588705647, 1046.5709059285657, 1213.1507944438752, 1234.8950339221087, 1251.7183633682348, 1261.1739310751473, 7132.465065120136, 7140.678669459887, 7165.534240274365, 7189.460790440738, 7212.026376439114, 434.7543637844608, 447.6239958434865, 449.4045389858451, 450.66875846252975, 451.2531759937309, 5455.0, 5474.7810087596845, 5586.078297081018, 5596.748146333425, 5646.407127251661, 9028.36801423894, 9360.391574547633, 9360.62557497706, 9379.437233765859, 9397.201237894855, 8773.736787896374, 9108.453492790453, 9151.130642588943, 9157.816843663222, 9181.311401644904, 6815.182178138655, 6889.655517224119, 6900.551464154814, 6938.514303998772, 6958.826029349206, 6495.447886929475, 6584.637844918576, 6617.437517810848, 6639.53523253387, 6647.069410282661, 8032.59837008159, 8112.310453611273, 8137.79655508617, 8179.918200818153, 8329.541875196923, 8177.345812335118, 8419.368547359096, 8507.064222935349, 8524.445911015764, 8549.829003420022, 5424.5660347172925, 5827.1841942127285, 6013.278406591237, 6096.847578810565, 6207.193064901534, 6959.0, 6960.234374218933, 6979.546329488567, 6991.510594258353, 7011.228764835966, 6218.284897236876, 6394.90407643895, 6457.709403076967, 6461.353864613501, 6498.0, 6091.573589848668, 6100.176476175659, 6192.133101365723, 6203.348648391854, 6327.209098862642, 6555.4427873629365, 6622.10601568782, 6646.501512386493, 6666.100076489612, 6672.699728512326, 6046.848828779316, 6060.909086363797, 6092.45167934888, 6095.3904609538695, 6106.3588323227195, 6321.336259692666, 6385.3295403983775, 6394.392532709385, 6396.328385519453, 6413.1021656969], "unit": "score", "name": "mootools.html", "value": 4178.278860133402}, {"lowerIsBetter": false, "replicates": [325.06543686900164, 325.8126577218097, 327.60196361420867, 328.3810018115852, 333.76803121830324, 5296.735163241837, 5333.413324534303, 5346.465353464651, 5354.14333706607, 5380.488853558905, 5274.4461831507715, 5276.103062479378, 5307.0, 5312.6281160318795, 5316.388615309231, 3936.252112098706, 4029.717919745619, 4086.1419101988467, 4142.2958097123565, 4143.896402589937, 4158.334666453368, 4169.124483858393, 4172.061286210609, 4176.97911510442, 4179.080602267496, 4119.217348703752, 4135.524414692319, 4139.151473947833, 4140.875773726793, 4141.109661422794, 3869.8645547405845, 3999.460072890152, 4099.200655872076, 4121.402396652498, 4132.938005929914, 3644.671979521856, 3653.7442379033478, 3657.9817100914324, 3660.4692319613505, 3664.6518580735055, 5139.58883289336, 5148.4851514848215, 5150.381954165524, 5156.510131537498, 5167.9224811627855, 4803.375561177025, 4805.846596816774, 4815.614750819926, 4817.445993710733, 4821.204501257288, 5610.523105536035, 5617.045102332613, 5623.550115990752, 5630.211770352154, 5635.690037047961, 4037.071473561068, 4045.939310910339, 4047.797610119482, 4050.675945924319, 4053.391991201314, 5716.314042314949, 5905.438983296623, 5906.675132867691, 5910.615809972338, 5911.999999999957, 3982.601739825994, 4018.7186896916937, 4020.3366444536323, 4025.1547175092974, 4042.43405923171, 4088.2436749200897, 4091.9181616367505, 4093.7134400592267, 4096.938545921814, 4098.282800509899, 4685.273782563708, 4689.413823272091, 4694.0, 4697.295405689106, 4701.153792317347, 5589.608727389043, 5589.80435684749, 5605.7197140142825, 5608.9439105609235, 5612.130119831432, 1424.4302279088447, 1443.256722787765, 1443.8628330308604, 1444.6677264229286, 1446.096189881324, 869.9913000870037, 888.2228050455851, 918.150710592699, 960.2078285414561, 963.4123184857232, 4820.469748327681, 4843.104025755247, 4869.902601947942, 4973.651844370932, 4975.0, 5905.261842269716, 5918.171455996164, 5918.201042859245, 5924.792632257937, 5935.169076329231, 4996.025774973918, 4998.475160108209, 5034.320366750442, 5035.949640503548, 5036.622253331015, 3095.969040309568, 3151.826649534252, 3164.114048066499, 3167.667394923546, 3172.191091271757, 5507.752151153128, 5508.3114610673665, 5514.09017512114, 5523.254360661259, 5524.1989911462615, 5801.158831969341, 5977.850553736104, 6018.729157187937, 6020.578559500793, 6032.0, 5459.69971651555, 5485.780568777204, 5494.478024587658, 5501.092319767274, 5502.80740174092, 5865.677387743715, 5867.266591676041, 5874.324452687995, 5876.941230587639, 5877.853053673522, 5660.405657405913, 5695.6330480685165, 5705.3153621564015, 5713.514351280188, 5719.942800572107, 5354.732263386893, 5498.752556135064, 5498.80754173602, 5508.476694713996, 5515.393306736336, 3957.2085582882964, 4051.291024070717, 4053.331200352027, 4057.0, 4058.2695114879607, 5836.066229403275, 5866.7066646668345, 5869.354371019099, 5871.207387002871, 5871.559633027626, 5672.914906276326, 5673.432656734293, 5676.829695109153, 5678.375378708256, 5685.459881311269, 5662.745176466987, 5666.923284575917, 5674.148877668217, 5676.432356764456, 5678.886422271614, 5363.865903352447, 5580.888382232414, 5580.916286255629, 5581.581381396492, 5584.525315348241, 5654.491095801398, 5654.773809047592, 5679.091345384719, 5681.545476361964, 5710.257666503494, 5577.888442231214, 5578.77684892616, 5580.135079062752, 5584.664920104807, 5587.273654424899], "unit": "score", "name": "prototype.html", "value": 4236.156304898227}, {"lowerIsBetter": false, "replicates": [615.9322474527803, 644.0371644391633, 702.2275496953349, 750.7597568777993, 788.7160622176016, 11738.941305293472, 11817.35004574748, 11838.112141589372, 11862.228955117922, 11906.583269585566, 11861.466234019468, 11881.405929703502, 11889.167758256925, 11978.880211197886, 11991.460384282707, 642.7172044300493, 791.2878409431501, 795.5862951265339, 809.2797410304834, 815.339574944297, 809.6882700160422, 814.242754238558, 815.1440986963694, 815.5840521334103, 816.4488969945293, 844.5270648436895, 847.7880529867533, 848.2196379331031, 848.6775025490335, 848.7326492154982, 669.2437545573495, 680.3842522517081, 680.4012469027274, 832.7501749475193, 842.418731075559, 627.0374974414298, 627.554436350192, 628.3402427451158, 629.9748010079592, 630.2059405149499, 12374.56689015889, 12406.62780116598, 12414.068944829083, 12420.875791242153, 12424.689382765413, 12306.507739690402, 12751.0, 12872.806907896389, 12934.0, 12984.870151298555, 10056.396616202977, 10069.194464442828, 10163.085322320952, 10324.741881452948, 10358.792824143551, 3355.9161020974425, 3418.743594230443, 3431.4509678451327, 3458.1354661334667, 3512.3853325667906, 43242.567574324166, 43600.0, 43765.78117109426, 43793.343099853526, 45033.09933801305, 9842.80314393708, 9920.355176913477, 9931.155851752683, 9970.351927124859, 10288.588456461808, 17869.553261168574, 17902.731459028124, 17914.193861276275, 17945.641087178185, 17972.55068623295, 6567.113439685581, 6911.274316196727, 6963.965180174168, 6977.33715297046, 6986.825329366705, 3747.437884317374, 3801.904952376213, 3804.6575808177395, 3847.2882516734494, 3882.864099756495, 2816.859157042181, 2818.0418657656496, 2827.3355761396056, 2873.267316834194, 2882.2218001139577, 528.5982653183531, 530.7478947499984, 538.9056915039853, 539.3285359727165, 543.760745272087, 482.32956190894686, 529.68000159302, 561.015398082207, 595.7259660556106, 601.9518438524907, 7901.525908445512, 8005.519668819889, 8222.958885205655, 8404.537750423786, 8430.578471076422, 569.5244470866872, 570.9600327977001, 576.5877397660693, 588.8262962426008, 593.1399470767404, 3629.364861149288, 3645.54430696163, 3705.814709264526, 3743.1765011697385, 3850.2876967761053, 52772.0, 53323.20015199775, 53376.466235337924, 54144.45855541473, 54233.1865022025, 44933.32600011003, 45110.0, 45314.54685453169, 45997.77001114973, 47278.0, 42771.57228427738, 43407.13185736268, 43489.130217395475, 43524.347134793, 43642.56357436448, 7623.4663573549315, 7687.194838554951, 7715.807104822425, 7725.266099720518, 7811.0, 31270.0, 32711.345773084882, 32976.835115824266, 33089.66910330962, 34091.0, 38082.0, 41307.7934610325, 41542.37686434646, 41781.79109104435, 42368.0, 8979.551022448983, 8988.955055224682, 9020.14308640678, 9034.728958131267, 9128.680496182602, 9989.350692204984, 10126.949365253127, 10133.13868321201, 10141.949290253502, 10167.542460589144, 9633.0, 9742.366746161477, 9809.509524523888, 9909.30634855582, 10175.542100605342, 9621.326507144713, 9835.0, 9903.108720215216, 9932.404055756677, 10009.749756256151, 9114.498702571422, 9453.149216570542, 9465.716028519155, 9478.0, 9500.192483638968, 7745.496542724705, 7909.841803163789, 7998.48142745817, 8228.917710823054, 8326.50040997542, 7934.920650793418, 8122.7157049502985, 8167.264946154874, 8241.374493644527, 8304.543250121302], "unit": "score", "name": "yui.html", "value": 5771.480547202659}], "name": "dromaeo_css", "value": 6276.060691815211}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 108.0, 114.0, 117.0, 112.0, 102.0, 113.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 156.0, 170.0, 132.0, 162.0, 158.0, 132.0, 180.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [75.0, 78.0, 106.0, 98.0, 74.0, 73.0, 75.0, 130.0, 100.0, 74.0], "unit": "score", "name": "audio-fft", "value": 88.3}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 150.0, 95.0, 94.0, 95.0, 142.0, 96.0, 94.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 148.0, 146.0, 148.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 74.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.4}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 84.0, 84.0, 82.0, 84.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [118.0, 125.0, 118.0, 116.0, 119.0, 118.0, 130.0, 124.0, 126.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [146.0, 130.0, 143.0, 142.0, 144.0, 136.0, 143.0, 144.0, 135.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 69.0, 73.0, 69.0, 68.0, 69.0, 71.0, 71.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1526.7000000000003}]} 20:05:02 INFO - Return code: 0 20:05:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:05:02 ERROR - # TBPL SUCCESS # 20:05:02 INFO - Running post-action listener: _resource_record_post_action 20:05:02 INFO - Running post-run listener: _resource_record_post_run 20:05:03 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519712768; Read time: 36; Write time: 750084 20:05:03 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233312256; Read time: 0; Write time: 463888 20:05:03 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286339072; Read time: 36; Write time: 286152 20:05:03 INFO - Running post-run listener: _upload_blobber_files 20:05:03 INFO - Blob upload gear active. 20:05:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:05:03 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 20:05:03 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'] 20:05:03 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 20:05:04 INFO - (blobuploader) - INFO - Open directory for files ... 20:05:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:05:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:05:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:05:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:05:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:05:05 INFO - (blobuploader) - INFO - Done attempting. 20:05:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:05:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:05:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:05:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:05:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:05:06 INFO - (blobuploader) - INFO - Done attempting. 20:05:06 INFO - (blobuploader) - INFO - Iteration through files over. 20:05:06 INFO - Return code: 0 20:05:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:05:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:05:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8b023b6c8d525f41280f2d078b0c06d843a2b502d5a0d67f9d87d36552e3fbade2d87bbec22fcca3ed7703371e97eb8b548105c2c4f260d32ff7384e2e0597d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7fcc0168d3165afdc831e12ebf2064ca92879b65ae85bb200b50b976bef6b33ee2c05525ac3597af379ea1fe36d2d9687f6eee21ae574eed5185885896c6adad"} 20:05:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:05:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:05:06 INFO - Contents: 20:05:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e8b023b6c8d525f41280f2d078b0c06d843a2b502d5a0d67f9d87d36552e3fbade2d87bbec22fcca3ed7703371e97eb8b548105c2c4f260d32ff7384e2e0597d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7fcc0168d3165afdc831e12ebf2064ca92879b65ae85bb200b50b976bef6b33ee2c05525ac3597af379ea1fe36d2d9687f6eee21ae574eed5185885896c6adad"} 20:05:06 INFO - Running post-run listener: copy_logs_to_upload_dir 20:05:06 INFO - Copying logs to upload dir... 20:05:06 INFO - mkdir: /builds/slave/test/build/upload/logs 20:05:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.788782 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-01 20:05:06.077472) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 20:05:06.080653) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240 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/e8b023b6c8d525f41280f2d078b0c06d843a2b502d5a0d67f9d87d36552e3fbade2d87bbec22fcca3ed7703371e97eb8b548105c2c4f260d32ff7384e2e0597d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7fcc0168d3165afdc831e12ebf2064ca92879b65ae85bb200b50b976bef6b33ee2c05525ac3597af379ea1fe36d2d9687f6eee21ae574eed5185885896c6adad"} build_url:https://queue.taskcluster.net/v1/task/PHxuU5GDTZK523r17RNR_Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/PHxuU5GDTZK523r17RNR_Q/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/e8b023b6c8d525f41280f2d078b0c06d843a2b502d5a0d67f9d87d36552e3fbade2d87bbec22fcca3ed7703371e97eb8b548105c2c4f260d32ff7384e2e0597d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7fcc0168d3165afdc831e12ebf2064ca92879b65ae85bb200b50b976bef6b33ee2c05525ac3597af379ea1fe36d2d9687f6eee21ae574eed5185885896c6adad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 20:05:06.109378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 20:05:06.109720) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1459564696.815421-1971110240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 20:05:06.195957) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 20:05:06.196280) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 20:05:06.196563) ========= ========= Total master_lag: 0.35 =========