builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1459780150.68 results: success (0) buildid: 20160404070930 builduid: 522a76fffb4b423292f185f30bf26298 revision: f03e513337dcdd1edff6eff905d7dc90c5f1abc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:10.676132) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:10.676557) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:10.677074) ========= 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=52faae308a556c440401f8e5000001e8-1459779712.671307-520526182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006416 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:10.704232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:10.706853) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:11.026307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:11.026624) ========= 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=52faae308a556c440401f8e5000001e8-1459779712.671307-520526182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:11.087382) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:11.087688) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:11.088395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:11.088670) ========= 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=52faae308a556c440401f8e5000001e8-1459779712.671307-520526182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-04 07:29:12-- 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% 35.5M=0s 2016-04-04 07:29:13 (35.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173526 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:11.294178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:11.294467) ========= 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=52faae308a556c440401f8e5000001e8-1459779712.671307-520526182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018073 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:11.366385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 07:29:11.366699) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f03e513337dcdd1edff6eff905d7dc90c5f1abc7 --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 f03e513337dcdd1edff6eff905d7dc90c5f1abc7 --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=52faae308a556c440401f8e5000001e8-1459779712.671307-520526182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-04 07:29:13,274 truncating revision to first 12 chars 2016-04-04 07:29:13,274 Setting DEBUG logging. 2016-04-04 07:29:13,274 attempt 1/10 2016-04-04 07:29:13,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f03e513337dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 07:29:14,061 unpacking tar archive at: fx-team-f03e513337dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.061394 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 07:29:12.440519) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:12.440819) ========= echo f03e513337dcdd1edff6eff905d7dc90c5f1abc7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f03e513337dcdd1edff6eff905d7dc90c5f1abc7'] 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=52faae308a556c440401f8e5000001e8-1459779712.671307-520526182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f03e513337dcdd1edff6eff905d7dc90c5f1abc7 program finished with exit code 0 elapsedTime=0.003433 script_repo_revision: 'f03e513337dcdd1edff6eff905d7dc90c5f1abc7' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:12.488681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:12.488990) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 07:29:12.498696) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-04 07:29:12.498964) ========= /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=52faae308a556c440401f8e5000001e8-1459779712.671307-520526182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:29:14 INFO - MultiFileLogger online at 20160404 07:29:14 in /builds/slave/test 07:29:14 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 07:29:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:29:14 INFO - {'append_to_log': False, 07:29:14 INFO - 'base_work_dir': '/builds/slave/test', 07:29:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:29:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:29:14 INFO - 'branch': 'Fx-Team-Non-PGO', 07:29:14 INFO - 'buildbot_json_path': 'buildprops.json', 07:29:14 INFO - 'config_files': ('talos/linux_config.py',), 07:29:14 INFO - 'default_actions': ('clobber', 07:29:14 INFO - 'read-buildbot-config', 07:29:14 INFO - 'download-and-extract', 07:29:14 INFO - 'populate-webroot', 07:29:14 INFO - 'create-virtualenv', 07:29:14 INFO - 'install', 07:29:14 INFO - 'run-tests'), 07:29:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:29:14 INFO - 'download_minidump_stackwalk': True, 07:29:14 INFO - 'download_symbols': 'ondemand', 07:29:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:29:14 INFO - 'tooltool.py': '/tools/tooltool.py', 07:29:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:29:14 INFO - '/tools/misc-python/virtualenv.py')}, 07:29:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:29:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:29:14 INFO - 'installer_path': 'installer.exe', 07:29:14 INFO - 'log_level': 'info', 07:29:14 INFO - 'log_name': 'talos', 07:29:14 INFO - 'log_to_console': True, 07:29:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:29:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:29:14 INFO - 'opt_config_files': (), 07:29:14 INFO - 'pip_index': False, 07:29:14 INFO - 'sps_profile': False, 07:29:14 INFO - 'sps_profile_interval': 0, 07:29:14 INFO - 'suite': 'dromaeojs', 07:29:14 INFO - 'system_bits': '32', 07:29:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:29:14 INFO - 'title': 'talos-linux64-ix-056', 07:29:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:29:14 INFO - 'use_talos_json': True, 07:29:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:29:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:29:14 INFO - 'work_dir': 'build'} 07:29:14 INFO - ##### 07:29:14 INFO - ##### Running clobber step. 07:29:14 INFO - ##### 07:29:14 INFO - Running pre-action listener: _resource_record_pre_action 07:29:14 INFO - Running main action method: clobber 07:29:14 INFO - rmtree: /builds/slave/test/build 07:29:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:29:14 INFO - Running post-action listener: _resource_record_post_action 07:29:14 INFO - ##### 07:29:14 INFO - ##### Running read-buildbot-config step. 07:29:14 INFO - ##### 07:29:14 INFO - Running pre-action listener: _resource_record_pre_action 07:29:14 INFO - Running main action method: read_buildbot_config 07:29:14 INFO - Using buildbot properties: 07:29:14 INFO - { 07:29:14 INFO - "project": "", 07:29:14 INFO - "product": "firefox", 07:29:14 INFO - "script_repo_revision": "production", 07:29:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:29:14 INFO - "repository": "", 07:29:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:29:14 INFO - "buildid": "20160404070930", 07:29:14 INFO - "pgo_build": "False", 07:29:14 INFO - "basedir": "/builds/slave/test", 07:29:14 INFO - "buildnumber": 1602, 07:29:14 INFO - "slavename": "talos-linux64-ix-056", 07:29:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:29:14 INFO - "platform": "ubuntu64_hw", 07:29:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:29:14 INFO - "branch": "fx-team", 07:29:14 INFO - "repo_path": "integration/fx-team", 07:29:14 INFO - "revision": "f03e513337dcdd1edff6eff905d7dc90c5f1abc7", 07:29:14 INFO - "stage_platform": "linux64", 07:29:14 INFO - "builduid": "522a76fffb4b423292f185f30bf26298", 07:29:14 INFO - "slavebuilddir": "test" 07:29:14 INFO - } 07:29:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:29:14 INFO - Running post-action listener: _resource_record_post_action 07:29:14 INFO - ##### 07:29:14 INFO - ##### Running download-and-extract step. 07:29:14 INFO - ##### 07:29:14 INFO - Running pre-action listener: _resource_record_pre_action 07:29:14 INFO - Running main action method: download_and_extract 07:29:14 INFO - mkdir: /builds/slave/test/build/tests 07:29:14 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')]} 07:29:14 INFO - https://queue.taskcluster.net/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:29:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:29:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:29:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-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 07:29:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-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 07:29:18 INFO - Downloaded 1361 bytes. 07:29:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:29:18 INFO - Using the following test package requirements: 07:29:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:29:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:29:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:29:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:18 INFO - u'jsshell-linux-x86_64.zip'], 07:29:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:29:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:29:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:29:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:29:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:29:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:29:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:29:18 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')]} 07:29:18 INFO - https://queue.taskcluster.net/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:29:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:29:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:29:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-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 07:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-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 07:29:21 INFO - Downloaded 22125701 bytes. 07:29:21 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'] 07:29:21 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 07:29:22 INFO - Return code: 0 07:29:22 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 07:29: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')]} 07:29:22 INFO - https://queue.taskcluster.net/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:29:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:29:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:29:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-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 07:29:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-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 07:29:31 INFO - Downloaded 22125701 bytes. 07:29:31 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'] 07:29:31 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 07:29:32 INFO - Return code: 0 07:29:32 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')]} 07:29:32 INFO - https://queue.taskcluster.net/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:29:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:29:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:29:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-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 07:29:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-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 07:29:33 INFO - Downloaded 10847584 bytes. 07:29:33 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'] 07:29:33 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 07:29:34 INFO - Return code: 0 07:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:34 INFO - https://queue.taskcluster.net/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:29:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:29:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:29:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-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 07:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOygN67xTmqMIC7A6daf-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 07:29:35 INFO - Downloaded 54086988 bytes. 07:29:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:29:35 INFO - mkdir: /builds/slave/test/properties 07:29:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:29:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:29:35 INFO - Contents: 07:29:35 INFO - build_url:https://queue.taskcluster.net/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:29:36 INFO - Running post-action listener: _resource_record_post_action 07:29:36 INFO - Running post-action listener: set_extra_try_arguments 07:29:36 INFO - ##### 07:29:36 INFO - ##### Running populate-webroot step. 07:29:36 INFO - ##### 07:29:36 INFO - Running pre-action listener: _resource_record_pre_action 07:29:36 INFO - Running main action method: populate_webroot 07:29:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:29:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:29:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:29:36 INFO - '--tppagecycles', 07:29:36 INFO - '7'], 07:29:36 INFO - 'tests': ['tsvgm']}}, 07:29:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:29:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:29:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:29:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:29:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:29:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:29:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:36 INFO - 'talos_options': ['--e10s'], 07:29:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:36 INFO - 'tests': ['damp', 'tps']}, 07:29:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:36 INFO - 'talos_options': ['--e10s'], 07:29:36 INFO - 'tests': ['damp', 'tps']}, 07:29:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:29:36 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 07:29:36 INFO - 'tests': ['dromaeo_dom']}, 07:29:36 INFO - 'other': {'tests': ['a11yr', 07:29:36 INFO - 'ts_paint', 07:29:36 INFO - 'tpaint', 07:29:36 INFO - 'sessionrestore', 07:29:36 INFO - 'sessionrestore_no_auto_restore', 07:29:36 INFO - 'tabpaint']}, 07:29:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:29:36 INFO - 'tests': ['a11yr', 07:29:36 INFO - 'ts_paint', 07:29:36 INFO - 'tpaint', 07:29:36 INFO - 'sessionrestore', 07:29:36 INFO - 'sessionrestore_no_auto_restore', 07:29:36 INFO - 'tabpaint']}, 07:29:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:29:36 INFO - 'tests': ['a11yr', 07:29:36 INFO - 'ts_paint', 07:29:36 INFO - 'tpaint', 07:29:36 INFO - 'sessionrestore', 07:29:36 INFO - 'sessionrestore_no_auto_restore', 07:29:36 INFO - 'tabpaint']}, 07:29:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:29:36 INFO - 'tests': ['a11yr', 07:29:36 INFO - 'ts_paint', 07:29:36 INFO - 'tpaint', 07:29:36 INFO - 'sessionrestore', 07:29:36 INFO - 'sessionrestore_no_auto_restore', 07:29:36 INFO - 'tabpaint']}, 07:29:36 INFO - 'other_l64': {'tests': ['a11yr', 07:29:36 INFO - 'ts_paint', 07:29:36 INFO - 'tpaint', 07:29:36 INFO - 'sessionrestore', 07:29:36 INFO - 'sessionrestore_no_auto_restore', 07:29:36 INFO - 'tabpaint']}, 07:29:36 INFO - 'other_nol64': {'tests': ['a11yr', 07:29:36 INFO - 'ts_paint', 07:29:36 INFO - 'tpaint', 07:29:36 INFO - 'sessionrestore', 07:29:36 INFO - 'sessionrestore_no_auto_restore', 07:29:36 INFO - 'tabpaint']}, 07:29:36 INFO - 'svgr': {'tests': ['tsvgx', 07:29:36 INFO - 'tsvgr_opacity', 07:29:36 INFO - 'tart', 07:29:36 INFO - 'tscrollx', 07:29:36 INFO - 'cart']}, 07:29:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:29:36 INFO - 'tests': ['tsvgx', 07:29:36 INFO - 'tsvgr_opacity', 07:29:36 INFO - 'tart', 07:29:36 INFO - 'tscrollx', 07:29:36 INFO - 'cart']}, 07:29:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:36 INFO - 'tests': ['tp5o']}, 07:29:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:36 INFO - 'talos_options': ['--e10s'], 07:29:36 INFO - 'tests': ['tp5o']}, 07:29:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:36 INFO - 'talos_options': ['--xperf_path', 07:29:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:36 INFO - 'tests': ['tp5n']}, 07:29:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:36 INFO - 'talos_options': ['--e10s', 07:29:36 INFO - '--xperf_path', 07:29:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:36 INFO - 'tests': ['tp5n']}}, 07:29:36 INFO - 'talos.zip': {'path': '', 07:29:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:29:36 INFO - Running post-action listener: _resource_record_post_action 07:29:36 INFO - ##### 07:29:36 INFO - ##### Running create-virtualenv step. 07:29:36 INFO - ##### 07:29:36 INFO - Running pre-action listener: _resource_record_pre_action 07:29:36 INFO - Running main action method: create_virtualenv 07:29:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:29:36 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 07:29:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:29:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:29:36 INFO - Using real prefix '/usr' 07:29:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:29:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:29:39 INFO - Installing pip.................done. 07:29:39 INFO - Return code: 0 07:29:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:39 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 0x7f46dd290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753410>, '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 0x1754310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17547a0>, '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': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', '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 07:29:39 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 07:29:39 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 07:29:39 INFO - Using env: {'DISPLAY': ':0', 07:29:39 INFO - 'HOME': '/home/cltbld', 07:29:39 INFO - 'LANG': 'en_US.UTF-8', 07:29:39 INFO - 'LANGUAGE': 'en_US:en', 07:29:39 INFO - 'LOGNAME': 'cltbld', 07:29:39 INFO - 'MAIL': '/var/mail/cltbld', 07:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:39 INFO - 'MOZ_NO_REMOTE': '1', 07:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:39 INFO - 'NO_EM_RESTART': '1', 07:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:39 INFO - 'PWD': '/builds/slave/test', 07:29:39 INFO - 'SHELL': '/bin/bash', 07:29:39 INFO - 'SHLVL': '1', 07:29:39 INFO - 'TERM': 'linux', 07:29:39 INFO - 'TMOUT': '86400', 07:29:39 INFO - 'USER': 'cltbld', 07:29:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', 07:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:39 INFO - '_': '/tools/buildbot/bin/python'} 07:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:39 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 07:29:39 INFO - Cleaning up... 07:29:39 INFO - Return code: 0 07:29:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:39 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 0x7f46dd290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753410>, '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 0x1754310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17547a0>, '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': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', '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 07:29:39 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 07:29:39 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 07:29:39 INFO - Using env: {'DISPLAY': ':0', 07:29:39 INFO - 'HOME': '/home/cltbld', 07:29:39 INFO - 'LANG': 'en_US.UTF-8', 07:29:39 INFO - 'LANGUAGE': 'en_US:en', 07:29:39 INFO - 'LOGNAME': 'cltbld', 07:29:39 INFO - 'MAIL': '/var/mail/cltbld', 07:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:39 INFO - 'MOZ_NO_REMOTE': '1', 07:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:39 INFO - 'NO_EM_RESTART': '1', 07:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:39 INFO - 'PWD': '/builds/slave/test', 07:29:39 INFO - 'SHELL': '/bin/bash', 07:29:39 INFO - 'SHLVL': '1', 07:29:39 INFO - 'TERM': 'linux', 07:29:39 INFO - 'TMOUT': '86400', 07:29:39 INFO - 'USER': 'cltbld', 07:29:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', 07:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:39 INFO - '_': '/tools/buildbot/bin/python'} 07:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:39 INFO - Downloading/unpacking psutil>=0.7.1 07:29:39 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 07:29:39 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 07:29:39 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 07:29:39 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 07:29:39 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 07:29:39 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 07:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:29:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:41 INFO - Installing collected packages: psutil 07:29:41 INFO - Running setup.py install for psutil 07:29:41 INFO - building 'psutil._psutil_linux' extension 07:29:41 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 07:29:41 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 07:29:42 INFO - building 'psutil._psutil_posix' extension 07:29:42 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 07:29:42 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 07:29:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:42 INFO - Successfully installed psutil 07:29:42 INFO - Cleaning up... 07:29:42 INFO - Return code: 0 07:29:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:29:42 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')]} 07:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:42 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')]} 07:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:42 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 0x7f46dd290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753410>, '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 0x1754310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17547a0>, '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': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', '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 07:29:42 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 07:29:42 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 07:29:42 INFO - Using env: {'DISPLAY': ':0', 07:29:42 INFO - 'HOME': '/home/cltbld', 07:29:42 INFO - 'LANG': 'en_US.UTF-8', 07:29:42 INFO - 'LANGUAGE': 'en_US:en', 07:29:42 INFO - 'LOGNAME': 'cltbld', 07:29:42 INFO - 'MAIL': '/var/mail/cltbld', 07:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:42 INFO - 'MOZ_NO_REMOTE': '1', 07:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:42 INFO - 'NO_EM_RESTART': '1', 07:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:42 INFO - 'PWD': '/builds/slave/test', 07:29:42 INFO - 'SHELL': '/bin/bash', 07:29:42 INFO - 'SHLVL': '1', 07:29:42 INFO - 'TERM': 'linux', 07:29:42 INFO - 'TMOUT': '86400', 07:29:42 INFO - 'USER': 'cltbld', 07:29:42 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', 07:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:42 INFO - '_': '/tools/buildbot/bin/python'} 07:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:29:42 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 07:29:42 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 07:29:42 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 07:29:42 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 07:29:42 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 07:29:42 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 07:29:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:29:44 INFO - Installing collected packages: mozsystemmonitor 07:29:44 INFO - Running setup.py install for mozsystemmonitor 07:29:44 INFO - Successfully installed mozsystemmonitor 07:29:44 INFO - Cleaning up... 07:29:44 INFO - Return code: 0 07:29:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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', '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 0x7f46dd290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753410>, '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 0x1754310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17547a0>, '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': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', '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 07:29: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:29: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 blobuploader==1.2.4 07:29:44 INFO - Using env: {'DISPLAY': ':0', 07:29:44 INFO - 'HOME': '/home/cltbld', 07:29:44 INFO - 'LANG': 'en_US.UTF-8', 07:29:44 INFO - 'LANGUAGE': 'en_US:en', 07:29:44 INFO - 'LOGNAME': 'cltbld', 07:29:44 INFO - 'MAIL': '/var/mail/cltbld', 07:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:44 INFO - 'MOZ_NO_REMOTE': '1', 07:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:44 INFO - 'NO_EM_RESTART': '1', 07:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:44 INFO - 'PWD': '/builds/slave/test', 07:29:44 INFO - 'SHELL': '/bin/bash', 07:29:44 INFO - 'SHLVL': '1', 07:29:44 INFO - 'TERM': 'linux', 07:29:44 INFO - 'TMOUT': '86400', 07:29:44 INFO - 'USER': 'cltbld', 07:29:44 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', 07:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:44 INFO - '_': '/tools/buildbot/bin/python'} 07:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:44 INFO - Downloading/unpacking blobuploader==1.2.4 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:46 INFO - Downloading blobuploader-1.2.4.tar.gz 07:29:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:29:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:29:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:47 INFO - Downloading docopt-0.6.1.tar.gz 07:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:29:47 INFO - Installing collected packages: blobuploader, requests, docopt 07:29:47 INFO - Running setup.py install for blobuploader 07:29:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:29:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:29:47 INFO - Running setup.py install for requests 07:29:48 INFO - Running setup.py install for docopt 07:29:48 INFO - Successfully installed blobuploader requests docopt 07:29:48 INFO - Cleaning up... 07:29:48 INFO - Return code: 0 07:29:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:48 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 0x7f46dd290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753410>, '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 0x1754310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17547a0>, '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': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', '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 07:29:48 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 07:29:48 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 07:29:48 INFO - Using env: {'DISPLAY': ':0', 07:29:48 INFO - 'HOME': '/home/cltbld', 07:29:48 INFO - 'LANG': 'en_US.UTF-8', 07:29:48 INFO - 'LANGUAGE': 'en_US:en', 07:29:48 INFO - 'LOGNAME': 'cltbld', 07:29:48 INFO - 'MAIL': '/var/mail/cltbld', 07:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:48 INFO - 'MOZ_NO_REMOTE': '1', 07:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:48 INFO - 'NO_EM_RESTART': '1', 07:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:48 INFO - 'PWD': '/builds/slave/test', 07:29:48 INFO - 'SHELL': '/bin/bash', 07:29:48 INFO - 'SHLVL': '1', 07:29:48 INFO - 'TERM': 'linux', 07:29:48 INFO - 'TMOUT': '86400', 07:29:48 INFO - 'USER': 'cltbld', 07:29:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', 07:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:48 INFO - '_': '/tools/buildbot/bin/python'} 07:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:48 INFO - Running setup.py (path:/tmp/pip-oUJMng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:48 INFO - Running setup.py (path:/tmp/pip-IK_gZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:48 INFO - Running setup.py (path:/tmp/pip-WnIyIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:48 INFO - Running setup.py (path:/tmp/pip-NOh0Ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:48 INFO - Running setup.py (path:/tmp/pip-jUfj6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:48 INFO - Running setup.py (path:/tmp/pip-omP9Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:48 INFO - Running setup.py (path:/tmp/pip-AgmGTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:49 INFO - Running setup.py (path:/tmp/pip-2kynJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:49 INFO - Running setup.py (path:/tmp/pip-VSgyiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:49 INFO - Running setup.py (path:/tmp/pip-5Ibtyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:49 INFO - Running setup.py (path:/tmp/pip-wAgo4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:49 INFO - Running setup.py (path:/tmp/pip-KF0pdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:49 INFO - Running setup.py (path:/tmp/pip-2q3Urx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:49 INFO - Running setup.py (path:/tmp/pip-i611Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:49 INFO - Running setup.py (path:/tmp/pip-KfIU8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:49 INFO - Running setup.py (path:/tmp/pip-WDQi0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:49 INFO - Running setup.py (path:/tmp/pip-_J7Sbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:49 INFO - Running setup.py install for manifestparser 07:29:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:29:49 INFO - Running setup.py install for mozcrash 07:29:49 INFO - Running setup.py install for mozdebug 07:29:50 INFO - Running setup.py install for mozdevice 07:29:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Running setup.py install for mozfile 07:29:50 INFO - Running setup.py install for mozhttpd 07:29:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Running setup.py install for mozinfo 07:29:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Running setup.py install for mozInstall 07:29:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Running setup.py install for mozleak 07:29:50 INFO - Running setup.py install for mozlog 07:29:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Running setup.py install for moznetwork 07:29:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Running setup.py install for mozprocess 07:29:51 INFO - Running setup.py install for mozprofile 07:29:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozrunner 07:29:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozscreenshot 07:29:51 INFO - Running setup.py install for moztest 07:29:51 INFO - Running setup.py install for mozversion 07:29:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:51 INFO - Cleaning up... 07:29:51 INFO - Return code: 0 07:29:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:51 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 0x7f46dd290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753410>, '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 0x1754310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17547a0>, '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': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', '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 07:29:51 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 07:29:51 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 07:29:51 INFO - Using env: {'DISPLAY': ':0', 07:29:51 INFO - 'HOME': '/home/cltbld', 07:29:51 INFO - 'LANG': 'en_US.UTF-8', 07:29:51 INFO - 'LANGUAGE': 'en_US:en', 07:29:51 INFO - 'LOGNAME': 'cltbld', 07:29:51 INFO - 'MAIL': '/var/mail/cltbld', 07:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:51 INFO - 'MOZ_NO_REMOTE': '1', 07:29:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:51 INFO - 'NO_EM_RESTART': '1', 07:29:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:51 INFO - 'PWD': '/builds/slave/test', 07:29:51 INFO - 'SHELL': '/bin/bash', 07:29:51 INFO - 'SHLVL': '1', 07:29:51 INFO - 'TERM': 'linux', 07:29:51 INFO - 'TMOUT': '86400', 07:29:51 INFO - 'USER': 'cltbld', 07:29:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', 07:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:51 INFO - '_': '/tools/buildbot/bin/python'} 07:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:51 INFO - Running setup.py (path:/tmp/pip-snY6eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:51 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)) 07:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:51 INFO - Running setup.py (path:/tmp/pip-UEVjJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:51 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)) 07:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:51 INFO - Running setup.py (path:/tmp/pip-21KoK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:52 INFO - Running setup.py (path:/tmp/pip-TWgbht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:52 INFO - Running setup.py (path:/tmp/pip-py0Ttm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:52 INFO - Running setup.py (path:/tmp/pip-maQhKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:52 INFO - Running setup.py (path:/tmp/pip-jO_u4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:52 INFO - Running setup.py (path:/tmp/pip-WwkIxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:52 INFO - Running setup.py (path:/tmp/pip-MVVsOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:52 INFO - Running setup.py (path:/tmp/pip-kZXLyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:52 INFO - Running setup.py (path:/tmp/pip-7cgBwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:52 INFO - Running setup.py (path:/tmp/pip-frCXco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:52 INFO - Running setup.py (path:/tmp/pip-bDISJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:52 INFO - Running setup.py (path:/tmp/pip-A8rbad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:52 INFO - Running setup.py (path:/tmp/pip-gf0xvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:52 INFO - Running setup.py (path:/tmp/pip-MiRAq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:52 INFO - Running setup.py (path:/tmp/pip-WH_vrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:53 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)) 07:29:53 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)) 07:29:53 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)) 07:29:53 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)) 07:29:53 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)) 07:29:53 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)) 07:29:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:54 INFO - Downloading blessings-1.6.tar.gz 07:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:54 INFO - Installing collected packages: blessings 07:29:54 INFO - Running setup.py install for blessings 07:29:55 INFO - Successfully installed blessings 07:29:55 INFO - Cleaning up... 07:29:55 INFO - Return code: 0 07:29:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:55 INFO - Reading from file tmpfile_stdout 07:29:55 INFO - Current package versions: 07:29:55 INFO - argparse == 1.2.1 07:29:55 INFO - blessings == 1.6 07:29:55 INFO - blobuploader == 1.2.4 07:29:55 INFO - docopt == 0.6.1 07:29:55 INFO - manifestparser == 1.1 07:29:55 INFO - mozInstall == 1.12 07:29:55 INFO - mozcrash == 0.17 07:29:55 INFO - mozdebug == 0.1 07:29:55 INFO - mozdevice == 0.48 07:29:55 INFO - mozfile == 1.2 07:29:55 INFO - mozhttpd == 0.7 07:29:55 INFO - mozinfo == 0.9 07:29:55 INFO - mozleak == 0.1 07:29:55 INFO - mozlog == 3.1 07:29:55 INFO - moznetwork == 0.27 07:29:55 INFO - mozprocess == 0.22 07:29:55 INFO - mozprofile == 0.28 07:29:55 INFO - mozrunner == 6.11 07:29:55 INFO - mozscreenshot == 0.1 07:29:55 INFO - mozsystemmonitor == 0.0 07:29:55 INFO - moztest == 0.7 07:29:55 INFO - mozversion == 1.4 07:29:55 INFO - psutil == 3.1.1 07:29:55 INFO - requests == 1.2.3 07:29:55 INFO - wsgiref == 0.1.2 07:29:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:55 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 0x7f46dd290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753410>, '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 0x1754310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17547a0>, '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': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', '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 07:29:55 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 07:29:55 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 07:29:55 INFO - Using env: {'DISPLAY': ':0', 07:29:55 INFO - 'HOME': '/home/cltbld', 07:29:55 INFO - 'LANG': 'en_US.UTF-8', 07:29:55 INFO - 'LANGUAGE': 'en_US:en', 07:29:55 INFO - 'LOGNAME': 'cltbld', 07:29:55 INFO - 'MAIL': '/var/mail/cltbld', 07:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:55 INFO - 'MOZ_NO_REMOTE': '1', 07:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:55 INFO - 'NO_EM_RESTART': '1', 07:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:55 INFO - 'PWD': '/builds/slave/test', 07:29:55 INFO - 'SHELL': '/bin/bash', 07:29:55 INFO - 'SHLVL': '1', 07:29:55 INFO - 'TERM': 'linux', 07:29:55 INFO - 'TMOUT': '86400', 07:29:55 INFO - 'USER': 'cltbld', 07:29:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', 07:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:55 INFO - '_': '/tools/buildbot/bin/python'} 07:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 INFO - Cleaning up... 07:29:55 INFO - Return code: 0 07:29:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:55 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 0x7f46dd290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753410>, '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 0x1754310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17547a0>, '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': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', '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 07:29:55 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 07:29:55 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 07:29:55 INFO - Using env: {'DISPLAY': ':0', 07:29:55 INFO - 'HOME': '/home/cltbld', 07:29:55 INFO - 'LANG': 'en_US.UTF-8', 07:29:55 INFO - 'LANGUAGE': 'en_US:en', 07:29:55 INFO - 'LOGNAME': 'cltbld', 07:29:55 INFO - 'MAIL': '/var/mail/cltbld', 07:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:55 INFO - 'MOZ_NO_REMOTE': '1', 07:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:55 INFO - 'NO_EM_RESTART': '1', 07:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:55 INFO - 'PWD': '/builds/slave/test', 07:29:55 INFO - 'SHELL': '/bin/bash', 07:29:55 INFO - 'SHLVL': '1', 07:29:55 INFO - 'TERM': 'linux', 07:29:55 INFO - 'TMOUT': '86400', 07:29:55 INFO - 'USER': 'cltbld', 07:29:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', 07:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:55 INFO - '_': '/tools/buildbot/bin/python'} 07:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:55 INFO - Downloading/unpacking jsonschema 07:29:55 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 07:29:55 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 07:29:55 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 07:29:55 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 07:29:55 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 07:29:55 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 07:29:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:29:57 INFO - Downloading/unpacking functools32 (from jsonschema) 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:57 INFO - Downloading functools32-3.2.3-2.tar.gz 07:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:29:57 INFO - warning: no files found matching '*.txt' 07:29:57 INFO - no previously-included directories found matching 'build' 07:29:57 INFO - no previously-included directories found matching 'dist' 07:29:57 INFO - no previously-included directories found matching '.git*' 07:29:57 INFO - Installing collected packages: jsonschema, functools32 07:29:58 INFO - Running setup.py install for functools32 07:29:58 INFO - warning: no files found matching '*.txt' 07:29:58 INFO - no previously-included directories found matching 'build' 07:29:58 INFO - no previously-included directories found matching 'dist' 07:29:58 INFO - no previously-included directories found matching '.git*' 07:29:58 INFO - Successfully installed jsonschema functools32 07:29:58 INFO - Cleaning up... 07:29:58 INFO - Return code: 0 07:29:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:58 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 0x7f46dd290f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753410>, '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 0x1754310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17547a0>, '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': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', '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 07:29:58 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 07:29:58 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 07:29:58 INFO - Using env: {'DISPLAY': ':0', 07:29:58 INFO - 'HOME': '/home/cltbld', 07:29:58 INFO - 'LANG': 'en_US.UTF-8', 07:29:58 INFO - 'LANGUAGE': 'en_US:en', 07:29:58 INFO - 'LOGNAME': 'cltbld', 07:29:58 INFO - 'MAIL': '/var/mail/cltbld', 07:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:58 INFO - 'MOZ_NO_REMOTE': '1', 07:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:58 INFO - 'NO_EM_RESTART': '1', 07:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:58 INFO - 'PWD': '/builds/slave/test', 07:29:58 INFO - 'SHELL': '/bin/bash', 07:29:58 INFO - 'SHLVL': '1', 07:29:58 INFO - 'TERM': 'linux', 07:29:58 INFO - 'TMOUT': '86400', 07:29:58 INFO - 'USER': 'cltbld', 07:29:58 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', 07:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:58 INFO - '_': '/tools/buildbot/bin/python'} 07:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:58 INFO - Downloading/unpacking flake8 07:29:58 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 07:29:58 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 07:29:58 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 07:29:58 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 07:29:58 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 07:29:58 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 07:30:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:30:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:30:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:30:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:30:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:30:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:30:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:30:00 INFO - no previously-included directories found matching 'docs/_build' 07:30:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:30:01 INFO - Running setup.py install for pep8 07:30:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:30:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:30:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:30:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:30:01 INFO - no previously-included directories found matching 'docs/_build' 07:30:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:30:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:30:01 INFO - Cleaning up... 07:30:01 INFO - Return code: 0 07:30:01 INFO - Running post-action listener: _resource_record_post_action 07:30:01 INFO - Running post-action listener: _start_resource_monitoring 07:30:01 INFO - Starting resource monitoring. 07:30:01 INFO - ##### 07:30:01 INFO - ##### Running install step. 07:30:01 INFO - ##### 07:30:01 INFO - Running pre-action listener: _resource_record_pre_action 07:30:01 INFO - Running main action method: install 07:30:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:01 INFO - Reading from file tmpfile_stdout 07:30:01 INFO - Detecting whether we're running mozinstall >=1.0... 07:30:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:30:01 INFO - Reading from file tmpfile_stdout 07:30:01 INFO - Output received: 07:30:01 INFO - Usage: mozinstall [options] installer 07:30:01 INFO - Options: 07:30:01 INFO - -h, --help show this help message and exit 07:30:01 INFO - -d DEST, --destination=DEST 07:30:01 INFO - Directory to install application into. [default: 07:30:01 INFO - "/builds/slave/test"] 07:30:01 INFO - --app=APP Application being installed. [default: firefox] 07:30:01 INFO - mkdir: /builds/slave/test/build/application 07:30:01 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'] 07:30:01 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 07:30:17 INFO - Reading from file tmpfile_stdout 07:30:17 INFO - Output received: 07:30:17 INFO - /builds/slave/test/build/application/firefox/firefox 07:30:17 INFO - Running post-action listener: _resource_record_post_action 07:30:17 INFO - ##### 07:30:17 INFO - ##### Running run-tests step. 07:30:17 INFO - ##### 07:30:17 INFO - Running pre-action listener: _resource_record_pre_action 07:30:17 INFO - Running main action method: run_tests 07:30:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:30:17 INFO - Python 2.7.3 07:30:17 INFO - Return code: 0 07:30:17 INFO - grabbing minidump binary from tooltool 07:30:17 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')]} 07:30:17 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 0x1753410>, '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 0x1754310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17547a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:30:17 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 07:30:17 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 07:30:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:30:17 INFO - Return code: 0 07:30:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:30:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:30:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:30:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:30:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:30:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:30:18 INFO - Return code: 0 07:30:18 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/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 07:30:18 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/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 07:30:18 INFO - Using env: {'DISPLAY': ':0', 07:30:18 INFO - 'HOME': '/home/cltbld', 07:30:18 INFO - 'LANG': 'en_US.UTF-8', 07:30:18 INFO - 'LANGUAGE': 'en_US:en', 07:30:18 INFO - 'LOGNAME': 'cltbld', 07:30:18 INFO - 'MAIL': '/var/mail/cltbld', 07:30:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:30:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:18 INFO - 'MOZ_NO_REMOTE': '1', 07:30:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:18 INFO - 'NO_EM_RESTART': '1', 07:30:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:18 INFO - 'PWD': '/builds/slave/test', 07:30:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:30:18 INFO - 'SHELL': '/bin/bash', 07:30:18 INFO - 'SHLVL': '1', 07:30:18 INFO - 'TERM': 'linux', 07:30:18 INFO - 'TMOUT': '86400', 07:30:18 INFO - 'USER': 'cltbld', 07:30:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459779712.671307-520526182', 07:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:18 INFO - '_': '/tools/buildbot/bin/python'} 07:30:18 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/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 07:30:18 INFO - mozversion application_buildid: 20160404070930 07:30:18 INFO - mozversion application_changeset: f03e513337dcdd1edff6eff905d7dc90c5f1abc7 07:30:18 INFO - mozversion application_display_name: Nightly 07:30:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:30:18 INFO - mozversion application_name: Firefox 07:30:18 INFO - mozversion application_remotingname: firefox 07:30:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:30:18 INFO - mozversion application_vendor: Mozilla 07:30:18 INFO - mozversion application_version: 48.0a1 07:30:18 INFO - mozversion platform_buildid: 20160404070930 07:30:18 INFO - mozversion platform_changeset: f03e513337dcdd1edff6eff905d7dc90c5f1abc7 07:30:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:30:18 INFO - mozversion platform_version: 48.0a1 07:30:18 INFO - using testdate: 1459780218 07:30:18 INFO - actual date: 1459780218 07:30:18 INFO - starting webserver on 'localhost:57920' 07:30:18 INFO - SUITE-START | Running 2 tests 07:30:18 INFO - TEST-START | dromaeo_css 07:30:18 INFO - operating with platform_type : linux_ 07:30:18 INFO - Initialising browser for dromaeo_css test... 07:30:18 INFO - TEST-INFO | started process 28494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEEv0Hb/profile http://localhost:57920/getInfo.html) 07:30:23 INFO - PROCESS | 28494 | __metrics Screen width/height:1600/1200 07:30:23 INFO - PROCESS | 28494 | colorDepth:24 07:30:23 INFO - PROCESS | 28494 | Browser inner width/height: 1024/697 07:30:23 INFO - PROCESS | 28494 | __metrics 07:30:24 ERROR - PROCESS | 28494 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:30:24 INFO - TEST-INFO | 28494: exit 0 07:30:24 INFO - Browser initialized. 07:30:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:30:24 INFO - TEST-INFO | started process 28574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEEv0Hb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:36 INFO - PROCESS | 28574 | RSS: Main: 155021312 07:30:36 INFO - PROCESS | 28574 | 07:31:27 INFO - PROCESS | 28574 | 1459780287969 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] 07:33:39 INFO - PROCESS | 28574 | Cycle 1(1): loaded http://localhost:57920/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57920/tests/dromaeo/cssquery-ext.html) 07:33:40 INFO - PROCESS | 28574 | RSS: Main: 270229504 07:33:40 INFO - PROCESS | 28574 | 07:36:43 INFO - PROCESS | 28574 | Cycle 1(1): loaded http://localhost:57920/tests/dromaeo/cssquery-ext.html (next: http://localhost:57920/tests/dromaeo/cssquery-jquery.html) 07:36:43 INFO - PROCESS | 28574 | RSS: Main: 240726016 07:36:43 INFO - PROCESS | 28574 | 07:39:45 INFO - PROCESS | 28574 | Cycle 1(1): loaded http://localhost:57920/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57920/tests/dromaeo/cssquery-mootools.html) 07:39:46 INFO - PROCESS | 28574 | RSS: Main: 243011584 07:39:46 INFO - PROCESS | 28574 | 07:42:48 INFO - PROCESS | 28574 | Cycle 1(1): loaded http://localhost:57920/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57920/tests/dromaeo/cssquery-prototype.html) 07:42:48 INFO - PROCESS | 28574 | RSS: Main: 201560064 07:42:48 INFO - PROCESS | 28574 | 07:45:51 INFO - PROCESS | 28574 | Cycle 1(1): loaded http://localhost:57920/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57920/tests/dromaeo/cssquery-yui.html) 07:45:52 INFO - PROCESS | 28574 | RSS: Main: 198811648 07:45:52 INFO - PROCESS | 28574 | 07:48:54 INFO - PROCESS | 28574 | Cycle 1(1): loaded http://localhost:57920/tests/dromaeo/cssquery-yui.html (next: http://localhost:57920/tests/dromaeo/cssquery-dojo.html) 07:48:54 INFO - PROCESS | 28574 | RSS: Main: 267927552 07:48:54 INFO - PROCESS | 28574 | 07:48:54 INFO - PROCESS | 28574 | __start_tp_report 07:48:54 INFO - PROCESS | 28574 | _x_x_mozilla_page_load 07:48:54 INFO - PROCESS | 28574 | _x_x_mozilla_page_load_details 07:48:54 INFO - PROCESS | 28574 | |i|pagename|runs| 07:48:54 INFO - PROCESS | 28574 | |0;dojo.html;2583.793296536277;2634.078072674563;2657.747513986171;2681.6379788728514;2682.3830518980635;4447.955520444794;4488.910221795562;4519;4522.231220692482;4564.817407303713;4429.60133587977;4503.527129651388;4520.412346394964;4578.427696537933;4622.168009758242;4208.684348673846;4210.6631469482445;4264.253755592775;4278.7218830776055;4353.25994580922;4279.914401711964;4296.828126874937;4315.935260971088;4355.5644435556505;4357.12857428514;4155.542890282067;4165.500139983191;4224.366345048236;4233.089885674564;4248.341507066394;4175.5615660355525;4186.162767446523;4224.38746381776;4240.342746874239;4280.400743895857;4147.39862719907;4176.958230417687;4214.283571792803;4226.260404429213;4248.808803603845;4358.847440339573;4415.492218394861;4457.130859482402;4469.083837813273;4512.503624601291;4818.132736107499;4826.927596086061;4834.081524510332;4859;4874.195757699975;4851.878703032417;4856.732879691615;4864.513548645143;4867.269909513566;4918.9754051229875;4529.796159172845;4591.484810012687;4597.770111494412;4657.580817726353;4680.040591678698;5011.824586139541;5016.623753218523;5020;5035.068512325159;5059.19052951526;4790.377250957354;4810.350602668665;4813.7593120343845;4817.325574419584;4859.586935110485;4799.0401919616215;4865.56209941107;4905.583025442806;4940.431850337257;4958.429780575208;4841.080194763054;4853.102176097434;4856.247281671276;4871.29366241893;4907.092187945242;4740.265258884879;4846.830360937421;4848.7090774553635;4865.172920603506;4909.2881532177635;4206.684498662613;4240.427542281815;4244.596763307481;4278.743275403485;4316.762578058237;3604.7296452766145;3616.945745813815;3628.9092772680365;3655.3785856403942;3656.305301992613;4160.079296245818;4161.479815023122;4167.270727622654;4169.56219596944;4221.430106935524;4840.903181936342;4877.146499362598;4944.75276236194;4983.377077865267;5007.524285192901;4174.645155161846;4239.300515414922;4242.4272723181975;4243.384709217146;4270.935935960963;4343.891402714894;4470.848052123245;4509.057528150421;4510.1656193604285;4537.296719008559;4651.534846515321;4694.530546945278;4706.0823139487475;4748.264019077049;4749.287606859068;4848.9757551212015;4858.82994095205;4861.173600487855;4861.611071114232;4889.144399729962;4537.137943790669;4568.908621827612;4617.699849509771;4620.976895115503;4667.83662571822;4833.540813622841;4834.419869615528;4850.5149485052625;4861.173600487855;4904.190808516555;4877.244027175793;4898.142825005681;4922.72924989129;4925.581325587222;4940.2342636891335;4675.111728771522;4733.242681170997;4780.235162374003;4795.136875362468;4809.879753006203;4745.477997420212;4759.381280433521;4763.095011947719;4790.7844147012775;4824.927626085681;4729.314249433882;4733.029728905635;4748.62011039123;4771.78319528518;4782.163121453662;4610.792514336796;4636.60588849938;4692.038132182963;4735.715857048588;4814.133455977818;4542.568455996675;4554.544545545551;4559.475660299108;4680.789364478538;4746.240601503743 07:48:54 INFO - PROCESS | 28574 | |1;ext.html;514.2671692837706;522.7386306846577;524.8373004368649;538.9649672771268;558.0206737176255;34240.65759342406;34582.8270858646;34862.65137348626;34930.12674683131;35022.64977350226;37839.621603783955;38971.22057558847;38973.61026389735;39009;39029.609703902956;7757.883631745528;7931.246531579491;7936.642851071716;7944.165862584432;7953.284204421601;7628;7827.960860195691;7872;7886.29023387895;7895.486793358414;7885.566293853835;7993.2806047455715;7994;8004.079530853968;8008.519488830689;7784.455088143832;7898.881516777195;7948.244916732901;7952.244536768998;7953.4432589718745;7843.6470358833985;7971.441999060068;7980.082290536547;7981.920180798175;7986.161453047463;35311.646883531095;35445.29109417823;35711.4643280351;35740.82129589361;35754.82122589397;2183.5087105401317;2286.897089630954;2898.231968528342;2952.7047295270518;3092.3815236952473;26050.609240861402;26206.344841378927;26310.73689263102;26610.201693949213;26990.325241868915;3146.9685303146903;3184.8407579620925;3216.1477208539754;3283.3269179818317;3358.647342029101;165527.9999999988;165570;165608;165645;165914;48100.27849582259;48239;48360.5163948356;48546.514534854905;48548.27177592339;58650.41349586449;60258.39741602616;60335.69832150899;60375.39624603698;60614.39385606175;13940;14072.437102515785;14227.644308892153;14264.857351426353;14278.785818212735;10882.075023622923;11035.172362072877;11040.171987101;11072.778544429066;11077.224594278323;18438.35465758692;18534.44396668102;18637.254509819726;19212.71180932287;19237.61524769525;6823.215330236987;6872.41584465326;7019.8596028079155;7022;7103.680334384965;827.3174630929507;835.5863847395457;865.6104752861238;872.1845074855031;899.8920129584492;26823.26909209443;27129.728702713113;27299.31751706223;27515.724842751715;27519.31201719933;980.5342462330336;1028.840529717895;1031.4945676618404;1043.9895601044045;1052;14311.57065288043;14578.562643120724;14639;14778.48275310359;14904.329305181293;353543;358273;358949;358960;359150;48358;49593.25610115851;49717;49878.750606247464;50089.74955125201;1112.1547623805966;1210.0863847794858;1210.6247063410372;1223.174357308813;1244.153975296807;25465.363365916;25803.936464778377;25991.74008259893;26091.478170436865;27975.440491190468;39959.60040399559;40207.396889047275;40464.3930341051;40580.1883962325;40586;228827;229721;230229;230254;230499;33035;33895.66104339024;38557.42163867488;39470.60529394669;39548.40677389784;36427.27145457023;37664;37760.62239377571;40887.386689200284;40982;34377.484337735455;34417;34624;34995;35200;34194.658053419145;34358;34446.48330274998;34476.482852757734;34939;34518.65481345155;34537.48193777146;34861.12847178841;35224;35985.640143598226;28249.717502824707;30437.847810760806;30510.694893050786;30597.54103688491;30887.536686949265;24172.274831755076;24208.376911200477;24494.877525612257;24713.752862471145;24750.876245619376 07:48:54 INFO - PROCESS | 28574 | |2;jquery.html;342.21803179734314;344.8379261746978;348.626969143017;353.79479901657044;354.06350203711185;14599.927000364996;15573.766393504107;15888.126153061577;15901.443449479271;16122.193890305482;16346.509604711848;16454.095024773633;16571.751423728652;16800.579985500368;17011.65976680469;4791.897863491399;4832.4442689090765;4974.10466116099;4981.2030075187795;5022.497750224985;4822.614190864722;4889.853304400855;4923;4923.77842997066;4926.211806111023;4882.584980276681;4889.535494128052;4890.144224760653;4901.558859702626;4920.163572192736;4892.461829198785;5566.805161819337;5796.188533605298;5803.941960580382;5806.767729290823;5159.529534082769;5164.535191832753;5165.121929271995;5177.275181474596;5178.741062946838;12343.5062597496;18797.436076917576;18848.5287867803;18897.716534252;18906.338278160198;1791.4715159027987;1801.8558515318744;1825.470613522077;1836.623492184099;1842.8709990300683;9271;9393.812123757487;9699.563519641633;11804.527818887234;13234.66913327165;1745.127436281859;1765.7881054273441;1774.8225177482277;1778.644271145763;1795.8204179581937;54274.72862635701;60178;61437.69281153566;61903.38096619021;62802;9406.71779846592;9486;9537.093976072261;9568.76078098053;9642.132208101304;13022.739545209042;13142.60572182836;13165.407556659782;13171.341432928315;13178.364327134612;6986.825329366705;7031.08595882532;7046.1192350956135;7081.752138675121;7146.392556632641;6599.010148477671;6601.3068627794355;6828.5902845829405;6837.982795075464;6971.651417429108;3923.1172986078473;3980.5422376426504;4112.856050038235;4158.397032430341;4238.788060596958;1761.9911900440416;1767.45208985215;1791.4536066499843;1791.739034956393;1800.4598620413824;785.3795501553823;839.9748007559783;863.218786997768;876.5529579914162;922.686286662538;15441.922790386201;16136.515904522883;16209.513714588582;16211.351545938267;16302.429414970418;837.2966707965338;871.5598622695499;873.4715497124275;890.3544929925881;921.0329154387999;9043.77390565228;9109.77225569366;9221.446713197229;9465.432074075577;9576.281778866613;370542;372930;375032;377357;377470;66556.66721666457;70709;73559.63220183972;74699;75256.62371688106;980.563649176124;991.0931497679686;1015.4110615842793;1039.8076355874186;1046.4715318763976;14207.857921420653;14773.670369666352;15025.173615450818;15255.466058687893;15405.229738512806;30502.542461862646;31084.68915310818;31262.843685781427;33417.83291083529;34799.710484938136;44130.33804492871;44396.778016111006;44490.3326450097;44496.33255501105;44928;7444.478886477895;7654.2345765423015;7677.424193185645;7679.846403072019;7746.457747957589;10422.478876056015;11429.371384573597;11454.541818327174;11653.242539234923;11694.824577631172;5544.057510223352;7144.535605185646;9902.009799020329;10108.39349639024;10191.490425478549;9651.324407291422;9872.950635246778;10029.398236105566;10076.69769906904;10214.285000049926;9989.650362237287;10066.295359324777;10186.49067546605;10353.585856565955;10518.842217366899;7281.890771638324;7405;7579.5073320234005;7617.390608751398;7711.652975616223;7487.700491980259;8843.690470833748;9782.070703283176;10559.577616895545;10643.680689579325 07:48:54 INFO - PROCESS | 28574 | |3;mootools.html;1300.6488248173;1384.6399936016635;1425.2588653899968;1538.9692206155878;1738.852197563207;6922.792316230509;7097.680604372803;7099.751508697196;7108.822279443017;7116.964415177923;6980.511364204508;7099.325564071405;7117.252688467701;7172.282771722825;7177.3540381365665;1845.713914343279;2147.38799442159;2167.143978128638;2195.978040219601;2204.64725643897;2201.38361258847;2213.4134454369605;2216.434809123671;2222.688823564702;2226.9665955010687;2113.957720845582;2197.7582465928735;2200.801927826495;2201.2625770366944;2201.6147174244525;2180.062573093569;2198.5492973940386;2204.2064856651673;2224.3882932193615;2229.4537838229576;2192.78072192781;2197.9120835166573;2201.9449513762124;2202.7136472258503;2203.31697173875;7274.854502909965;7382.741604043833;7403;7414.073240844895;7426.962865185694;4274.957250427487;4400.471943366784;4415.183191109655;4417.580329868657;4421.314696222091;2817.2393453767368;2886.350571121502;2924.517454619985;2937.9265518362;2939.544370622557;976.038601977052;988.6737376665754;1000.1198944928417;1005.9497025148713;1023.247912784103;9830.410175389428;9839.86841513228;9849.90150098497;9855.802883942353;9904.653337133166;3943.7042221833476;4029.5768944261017;4102.097538541516;4124.52567954683;4136.9793151034655;8461.873071903927;8590.269827064645;8594.699185528476;8644.351673624504;8650.307975361957;3729.21686445844;4466.307722302983;4473.776311184428;4494.505604383515;4497.2129877271345;3914.2171565686976;3943.0536671198706;3972.5232972042963;3978.781167035841;3989.082511022423;3357.1439282982683;3424.2466657335344;3427.862885484553;3453.723702103826;3455.4125798614295;1135.1769966774023;1139.840422340873;1145.1068166829718;1148.5061423587938;1155.9595414160465;1154.8960593546622;1166.836642869999;1177.7232350397649;1188.477070089158;1199.6161228406827;6552.6068435894;6590.736370545124;6590.7693230736695;6605.042268870987;6690.565113267719;995.5470261031213;1013.1287093099928;1037.4345981440133;1044.7597052677927;1060.8620879285643;5328.786848526015;5333.5199832015305;5336.359636843604;5389.946100539023;5392.973035134799;8239.876401853977;8847.823043539092;8951.194392504705;9005.279577633904;9057.139571740674;8809.955950220336;8818;8851.64593416269;8871.112888711206;8890.688825891062;6597.175353080865;6830.624315662587;6848.554843935228;6865.965670171717;7000.789976300719;6680.3987641112535;6694.062831203538;6713.597184168965;6715.462762978852;6728.428083612752;7758.61206939662;8049.919500804917;8085.716999904975;8215.876761848458;8234.505929644241;8272.710455134042;8509.574521273787;8517.44636598619;8524.74425767228;8541.487510749375;6092.116643086816;6277.1525844010475;6278.968605156945;6283.403076707706;6301.6219026858535;6804.727810887509;6804.761833336008;6846.5892046477375;6866.759663411756;6873.862522749617;6061.212042434456;6200.3799620037635;6267.2165979252595;6307.842303942254;6347.270063942706;6129.601575897553;6171.413715697002;6213.161223234805;6302.810915672354;6328.968355158195;6317.305096439296;6320.5891617044745;6331.398517140864;6336.778212762531;6343.429091381798;5873.588848780715;5885.852853678693;5910.881782364415;5927.881442371215;5948.048312270016;6106.877862442815;6148.569600127948;6152.0156774915795;6157.907631385443;6166.845828854314 07:48:54 INFO - PROCESS | 28574 | |4;prototype.html;284.72097344602287;287.70222819381945;290.25404709895565;290.9607203027591;294.35829890837977;5248.868778280545;5250.976059668362;5252.054630166574;5260.0268950244235;5266.736663166836;5006.12392831254;5155.974220128904;5168.121419358708;5180.8704782380455;5202.271681964518;3805.84969492236;3958.366661334187;4014.939775903371;4027.8791636250958;4049.7975101244965;4052.533958594755;4058.330375488056;4080.5511393746665;4081.755094694313;4094.160697057111;4048.696347773914;4059.63463288304;4060.8984775380554;4068.8575899843363;4075.368317910714;3853.9614603854025;3938.9015274618077;4016.0763024504236;4024.2957482440456;4026.7583944963394;3540.628234035415;3550.0769799851964;3551.698105661022;3554.3957527220437;3556.110972256936;4876.341693871317;4883.145449546315;4948.406191257036;4950.554450099472;4969.602431805483;4660.300954856764;4661.067786442691;4661.976690116528;4667.533246675339;4681.993371425126;5379.596530260207;5424.647397919122;5468.91796623051;5488.670679759187;5502.339719233678;3868.825902834351;3873.0511024798825;3877;3949.269385163754;3950.071733142709;5465.316835395575;5598.412166722476;5716.114002329646;5727.684977326246;5759.3376761672525;3872.9419058714143;3884.941725874114;3896.902577435587;3897.0647044709067;3909.4135879617716;3945.881623551298;3945.921081578352;3950.0322421007036;3953.367461206193;3956.3669812829808;4565.931511027337;4567.931481027787;4567.931481027787;4576.679632425765;4577.22187228172;5485.588580856452;5486.588505862076;5489.698066606375;5492.615516913777;5494.780208791683;1406.2406300597768;1423.8647328503775;1424.4658253155067;1425.4013314407973;1425.7433661940743;900.6577500549749;944.0696979851047;945.1729736480579;972.3825370889394;993.3543196922059;4719.622430205575;4762.261849413347;4780.306855505932;4784.665073444895;4791.5687588117235;5619.353774316006;5623.268975033219;5623.578231632644;5632.9436705632415;5636.85907852307;4783.617310615212;4783.808647654055;4785.210440277316;4792.041591681677;4792.640551958617;2991.341904780945;3017.969820301769;3019.154636701727;3022.199117233935;3028.2732144285214;5339.919901201485;5343.465653434703;5345.7815006772535;5346.144616861284;5357.7589008494715;5651.350094739076;5751.884962300731;5838.328592211865;5877.5591830612875;5889.94110058894;5399.622026458189;5420.701861397661;5432.402435732066;5440.455954404528;5448.991936491761;5695.943040569541;5696.316442026983;5697.886042279214;5710.914336285042;5712.371639119777;5587.664740115606;5589.217509548747;5595.63628364155;5606;5618.578606604439;5415.972920135374;5427;5440.836774896601;5443.401225865073;5443.836684899459;3772.9434058488596;3867.8839634811;3875.147467557133;3879.80600969956;3893.2018936118593;5641.943580564306;5659.830205093854;5679.9432005681065;5690.5163061140265;5691.8861622768145;5464.153056276284;5470.480304371078;5475.151351540518;5479.835604931858;5480.123180291134;5421.457854214547;5473.179023146401;5481.287432633732;5482.068048431696;5493.066178749542;5408.8377348679605;5409.486098820763;5417.972910135424;5419.810306639406;5421.0513160196015;5356.7589458473685;5521.171824226398;5540.168974653834;5544.805931792368;5545.029619816597;5337.332833395825;5376.064616737893;5389.380221274603;5407.459254074561;5414.835810300647 07:48:54 INFO - PROCESS | 28574 | |5;yui.html;616.5499185594516;624.6907780648577;647.9060536222248;651.4007113455621;750.500916890268;10988.120950323975;11108.888911110886;11112.944435277823;11150.553977840877;11167.441627918612;11039.889601103987;11121.72195695108;11162.497687604056;11240.662780116589;11264.605738799144;801.603206412825;819.8073452738602;820.4625969989637;820.7906983719143;820.9548474833882;808.49873078691;816.3713940265992;816.8325493273894;816.8529664660359;818.9918100818975;847.3814115695546;851.833892390984;852.8209076094028;853.3002937591177;853.6286715278843;853.7780177153953;853.7950891785957;853.9829203415896;854.8888644476209;854.974350769478;625.9311475737666;626.2829060725444;627.2848952194502;627.6987046217795;627.8775638750445;10229;10256.33333833306;10269;10269.640562580349;10280.177585793193;10168.288219824615;10250.7437314067;10646.201534884915;10865.51105200268;10932.56269749209;8001.479903806234;8166.358723381111;8186.222308880647;8357.916420835774;8663.610137543825;3214.228585139573;3240.756943229267;3308.801471911669;3344.7491438142238;3382.374260761767;37972.62027379746;39358.21283574341;40699.09863069868;40801.1839763206;42433.151336973395;9769.90230097704;10015.39907605546;10067.295289329822;10133.189344852393;10168.389896606228;15394;15449.459268925533;15525.767113493306;15580.532584022498;15684.215789210493;6808.7276508939085;6984.61584612841;6995.265497122728;6995.720171193096;7068.539214716605;3780.0738818988975;3787.867424640124;3793.5447746270625;3851.2105018471707;3881.7865017423746;2849.6865344812054;2871.296532349546;2873.8563071846324;2880.812747171427;2884.7980641355325;492.31568120312795;506.8200788719951;511.7236692186252;527.8785879247795;547.8520799384144;542.7096503370677;564.5596434780878;573.5927491481011;574.2792795042195;580.1066357809011;6938.340857618518;7034.166662524097;7251.1298644163035;7401.296876796696;7564.0923089228545;552.1800126811762;560.2129008742723;569.2571194591015;570.2785975740692;577.5841394196173;3375.493675948578;3494.650534946485;3545.62770909056;3585.2112535242204;3666.450032495147;47301.763491182326;47913;52332.73833630807;52674.47325526772;52754;40150;40393;40430.79784601058;40564.18871622551;41117.79441102775;34795.13012174665;40261.798691006356;42851.35722964158;43336.566634333256;44170.33744493835;8022.478538895187;8132.390070744599;8138.145494722969;8146.83706325882;8310.750677479686;31412.685873140977;32289.35421291514;32890;33105.50341744828;33293.50059749057;41629.46149577199;42394;42909.57090429181;43033.13933721371;43049.354259686756;8446;8556;8612.224899759052;8697.8695319569;8768.824623507622;9056.320775941962;9172.6789562365;9335.159835614828;9395.577199026196;9541.141297283279;8776;8913.153250441197;8938.910610893809;8996.43260419884;9057.230135438562;8832.226333229188;8877.156670116328;8897;9017.954910225408;9128.256015876954;8953.865692014495;8976.41653292534;9152;9213.723588292361;9388.57751401175;8748.862647855738;8798;8986.68546600866;8998.14517620825;9154.633814647606;8622.094680058755;8909.777255568662;8960.910390896008;9089.31830112731;9210.447373157633 07:48:54 INFO - PROCESS | 28574 | __end_tp_report 07:48:54 INFO - PROCESS | 28574 | __start_cc_report 07:48:54 INFO - PROCESS | 28574 | _x_x_mozilla_cycle_collect,1102 07:48:54 INFO - PROCESS | 28574 | __end_cc_report 07:48:54 INFO - PROCESS | 28574 | __startTimestamp1459781334900__endTimestamp 07:48:54 INFO - PROCESS | 28574 | 07:48:54 INFO - PROCESS | 28574 | ------- Summary: start ------- 07:48:54 INFO - PROCESS | 28574 | Number of tests: 6 07:48:54 INFO - PROCESS | 28574 | 07:48:54 INFO - PROCESS | 28574 | [#0] dojo.html Cycles:165 Average:4526.42 Median:4651.53 stddev:454.88 (9.8%) stddev-sans-first:430.00 07:48:54 INFO - PROCESS | 28574 | Values: 2583.8 2634.1 2657.7 2681.6 2682.4 4448.0 4488.9 4519.0 4522.2 4564.8 4429.6 4503.5 4520.4 4578.4 4622.2 4208.7 4210.7 4264.3 4278.7 4353.3 4279.9 4296.8 4315.9 4355.6 4357.1 4155.5 4165.5 4224.4 4233.1 4248.3 4175.6 4186.2 4224.4 4240.3 4280.4 4147.4 4177.0 4214.3 4226.3 4248.8 4358.8 4415.5 4457.1 4469.1 4512.5 4818.1 4826.9 4834.1 4859.0 4874.2 4851.9 4856.7 4864.5 4867.3 4919.0 4529.8 4591.5 4597.8 4657.6 4680.0 5011.8 5016.6 5020.0 5035.1 5059.2 4790.4 4810.4 4813.8 4817.3 4859.6 4799.0 4865.6 4905.6 4940.4 4958.4 4841.1 4853.1 4856.2 4871.3 4907.1 4740.3 4846.8 4848.7 4865.2 4909.3 4206.7 4240.4 4244.6 4278.7 4316.8 3604.7 3616.9 3628.9 3655.4 3656.3 4160.1 4161.5 4167.3 4169.6 4221.4 4840.9 4877.1 4944.8 4983.4 5007.5 4174.6 4239.3 4242.4 4243.4 4270.9 4343.9 4470.8 4509.1 4510.2 4537.3 4651.5 4694.5 4706.1 4748.3 4749.3 4849.0 4858.8 4861.2 4861.6 4889.1 4537.1 4568.9 4617.7 4621.0 4667.8 4833.5 4834.4 4850.5 4861.2 4904.2 4877.2 4898.1 4922.7 4925.6 4940.2 4675.1 4733.2 4780.2 4795.1 4809.9 4745.5 4759.4 4763.1 4790.8 4824.9 4729.3 4733.0 4748.6 4771.8 4782.2 4610.8 4636.6 4692.0 4735.7 4814.1 4542.6 4554.5 4559.5 4680.8 4746.2 07:48:54 INFO - PROCESS | 28574 | 07:48:54 INFO - PROCESS | 28574 | [#1] ext.html Cycles:180 Average:41384.85 Median:34967.00 stddev:69326.60 (198.3%) stddev-sans-first:69453.16 07:48:54 INFO - PROCESS | 28574 | Values: 514.3 522.7 524.8 539.0 558.0 34240.7 34582.8 34862.7 34930.1 35022.6 37839.6 38971.2 38973.6 39009.0 39029.6 7757.9 7931.2 7936.6 7944.2 7953.3 7628.0 7828.0 7872.0 7886.3 7895.5 7885.6 7993.3 7994.0 8004.1 8008.5 7784.5 7898.9 7948.2 7952.2 7953.4 7843.6 7971.4 7980.1 7981.9 7986.2 35311.6 35445.3 35711.5 35740.8 35754.8 2183.5 2286.9 2898.2 2952.7 3092.4 26050.6 26206.3 26310.7 26610.2 26990.3 3147.0 3184.8 3216.1 3283.3 3358.6 165528.0 165570.0 165608.0 165645.0 165914.0 48100.3 48239.0 48360.5 48546.5 48548.3 58650.4 60258.4 60335.7 60375.4 60614.4 13940.0 14072.4 14227.6 14264.9 14278.8 10882.1 11035.2 11040.2 11072.8 11077.2 18438.4 18534.4 18637.3 19212.7 19237.6 6823.2 6872.4 7019.9 7022.0 7103.7 827.3 835.6 865.6 872.2 899.9 26823.3 27129.7 27299.3 27515.7 27519.3 980.5 1028.8 1031.5 1044.0 1052.0 14311.6 14578.6 14639.0 14778.5 14904.3 353543.0 358273.0 358949.0 358960.0 359150.0 48358.0 49593.3 49717.0 49878.8 50089.7 1112.2 1210.1 1210.6 1223.2 1244.2 25465.4 25803.9 25991.7 26091.5 27975.4 39959.6 40207.4 40464.4 40580.2 40586.0 228827.0 229721.0 230229.0 230254.0 230499.0 33035.0 33895.7 38557.4 39470.6 39548.4 36427.3 37664.0 37760.6 40887.4 40982.0 34377.5 34417.0 34624.0 34995.0 35200.0 34194.7 34358.0 34446.5 34476.5 34939.0 34518.7 34537.5 34861.1 35224.0 35985.6 28249.7 30437.8 30510.7 30597.5 30887.5 24172.3 24208.4 24494.9 24713.8 24750.9 07:48:54 INFO - PROCESS | 28574 | 07:48:54 INFO - PROCESS | 28574 | [#2] jquery.html Cycles:180 Average:22878.93 Median:24859.95 stddev:61646.78 (248.0%) stddev-sans-first:61796.49 07:48:54 INFO - PROCESS | 28574 | Values: 342.2 344.8 348.6 353.8 354.1 14599.9 15573.8 15888.1 15901.4 16122.2 16346.5 16454.1 16571.8 16800.6 17011.7 4791.9 4832.4 4974.1 4981.2 5022.5 4822.6 4889.9 4923.0 4923.8 4926.2 4882.6 4889.5 4890.1 4901.6 4920.2 4892.5 5566.8 5796.2 5803.9 5806.8 5159.5 5164.5 5165.1 5177.3 5178.7 12343.5 18797.4 18848.5 18897.7 18906.3 1791.5 1801.9 1825.5 1836.6 1842.9 9271.0 9393.8 9699.6 11804.5 13234.7 1745.1 1765.8 1774.8 1778.6 1795.8 54274.7 60178.0 61437.7 61903.4 62802.0 9406.7 9486.0 9537.1 9568.8 9642.1 13022.7 13142.6 13165.4 13171.3 13178.4 6986.8 7031.1 7046.1 7081.8 7146.4 6599.0 6601.3 6828.6 6838.0 6971.7 3923.1 3980.5 4112.9 4158.4 4238.8 1762.0 1767.5 1791.5 1791.7 1800.5 785.4 840.0 863.2 876.6 922.7 15441.9 16136.5 16209.5 16211.4 16302.4 837.3 871.6 873.5 890.4 921.0 9043.8 9109.8 9221.4 9465.4 9576.3 370542.0 372930.0 375032.0 377357.0 377470.0 66556.7 70709.0 73559.6 74699.0 75256.6 980.6 991.1 1015.4 1039.8 1046.5 14207.9 14773.7 15025.2 15255.5 15405.2 30502.5 31084.7 31262.8 33417.8 34799.7 44130.3 44396.8 44490.3 44496.3 44928.0 7444.5 7654.2 7677.4 7679.8 7746.5 10422.5 11429.4 11454.5 11653.2 11694.8 5544.1 7144.5 9902.0 10108.4 10191.5 9651.3 9873.0 10029.4 10076.7 10214.3 9989.7 10066.3 10186.5 10353.6 10518.8 7281.9 7405.0 7579.5 7617.4 7711.7 7487.7 8843.7 9782.1 10559.6 10643.7 07:48:54 INFO - PROCESS | 28574 | 07:48:54 INFO - PROCESS | 28574 | [#3] mootools.html Cycles:180 Average:5096.29 Median:6139.09 stddev:2619.08 (42.7%) stddev-sans-first:2610.88 07:48:54 INFO - PROCESS | 28574 | Values: 1300.6 1384.6 1425.3 1539.0 1738.9 6922.8 7097.7 7099.8 7108.8 7117.0 6980.5 7099.3 7117.3 7172.3 7177.4 1845.7 2147.4 2167.1 2196.0 2204.6 2201.4 2213.4 2216.4 2222.7 2227.0 2114.0 2197.8 2200.8 2201.3 2201.6 2180.1 2198.5 2204.2 2224.4 2229.5 2192.8 2197.9 2201.9 2202.7 2203.3 7274.9 7382.7 7403.0 7414.1 7427.0 4275.0 4400.5 4415.2 4417.6 4421.3 2817.2 2886.4 2924.5 2937.9 2939.5 976.0 988.7 1000.1 1005.9 1023.2 9830.4 9839.9 9849.9 9855.8 9904.7 3943.7 4029.6 4102.1 4124.5 4137.0 8461.9 8590.3 8594.7 8644.4 8650.3 3729.2 4466.3 4473.8 4494.5 4497.2 3914.2 3943.1 3972.5 3978.8 3989.1 3357.1 3424.2 3427.9 3453.7 3455.4 1135.2 1139.8 1145.1 1148.5 1156.0 1154.9 1166.8 1177.7 1188.5 1199.6 6552.6 6590.7 6590.8 6605.0 6690.6 995.5 1013.1 1037.4 1044.8 1060.9 5328.8 5333.5 5336.4 5389.9 5393.0 8239.9 8847.8 8951.2 9005.3 9057.1 8810.0 8818.0 8851.6 8871.1 8890.7 6597.2 6830.6 6848.6 6866.0 7000.8 6680.4 6694.1 6713.6 6715.5 6728.4 7758.6 8049.9 8085.7 8215.9 8234.5 8272.7 8509.6 8517.4 8524.7 8541.5 6092.1 6277.2 6279.0 6283.4 6301.6 6804.7 6804.8 6846.6 6866.8 6873.9 6061.2 6200.4 6267.2 6307.8 6347.3 6129.6 6171.4 6213.2 6302.8 6329.0 6317.3 6320.6 6331.4 6336.8 6343.4 5873.6 5885.9 5910.9 5927.9 5948.0 6106.9 6148.6 6152.0 6157.9 6166.8 07:48:54 INFO - PROCESS | 28574 | 07:48:54 INFO - PROCESS | 28574 | [#4] prototype.html Cycles:180 Average:4541.23 Median:5249.92 stddev:1334.98 (25.4%) stddev-sans-first:1299.93 07:48:54 INFO - PROCESS | 28574 | Values: 284.7 287.7 290.3 291.0 294.4 5248.9 5251.0 5252.1 5260.0 5266.7 5006.1 5156.0 5168.1 5180.9 5202.3 3805.8 3958.4 4014.9 4027.9 4049.8 4052.5 4058.3 4080.6 4081.8 4094.2 4048.7 4059.6 4060.9 4068.9 4075.4 3854.0 3938.9 4016.1 4024.3 4026.8 3540.6 3550.1 3551.7 3554.4 3556.1 4876.3 4883.1 4948.4 4950.6 4969.6 4660.3 4661.1 4662.0 4667.5 4682.0 5379.6 5424.6 5468.9 5488.7 5502.3 3868.8 3873.1 3877.0 3949.3 3950.1 5465.3 5598.4 5716.1 5727.7 5759.3 3872.9 3884.9 3896.9 3897.1 3909.4 3945.9 3945.9 3950.0 3953.4 3956.4 4565.9 4567.9 4567.9 4576.7 4577.2 5485.6 5486.6 5489.7 5492.6 5494.8 1406.2 1423.9 1424.5 1425.4 1425.7 900.7 944.1 945.2 972.4 993.4 4719.6 4762.3 4780.3 4784.7 4791.6 5619.4 5623.3 5623.6 5632.9 5636.9 4783.6 4783.8 4785.2 4792.0 4792.6 2991.3 3018.0 3019.2 3022.2 3028.3 5339.9 5343.5 5345.8 5346.1 5357.8 5651.4 5751.9 5838.3 5877.6 5889.9 5399.6 5420.7 5432.4 5440.5 5449.0 5695.9 5696.3 5697.9 5710.9 5712.4 5587.7 5589.2 5595.6 5606.0 5618.6 5416.0 5427.0 5440.8 5443.4 5443.8 3772.9 3867.9 3875.1 3879.8 3893.2 5641.9 5659.8 5679.9 5690.5 5691.9 5464.2 5470.5 5475.2 5479.8 5480.1 5421.5 5473.2 5481.3 5482.1 5493.1 5408.8 5409.5 5418.0 5419.8 5421.1 5356.8 5521.2 5540.2 5544.8 5545.0 5337.3 5376.1 5389.4 5407.5 5414.8 07:48:54 INFO - PROCESS | 28574 | 07:48:54 INFO - PROCESS | 28574 | [#5] yui.html Cycles:180 Average:11933.11 Median:573.94 stddev:13924.05 (2426.1%) stddev-sans-first:13937.18 07:48:54 INFO - PROCESS | 28574 | Values: 616.5 624.7 647.9 651.4 750.5 10988.1 11108.9 11112.9 11150.6 11167.4 11039.9 11121.7 11162.5 11240.7 11264.6 801.6 819.8 820.5 820.8 821.0 808.5 816.4 816.8 816.9 819.0 847.4 851.8 852.8 853.3 853.6 853.8 853.8 854.0 854.9 855.0 625.9 626.3 627.3 627.7 627.9 10229.0 10256.3 10269.0 10269.6 10280.2 10168.3 10250.7 10646.2 10865.5 10932.6 8001.5 8166.4 8186.2 8357.9 8663.6 3214.2 3240.8 3308.8 3344.7 3382.4 37972.6 39358.2 40699.1 40801.2 42433.2 9769.9 10015.4 10067.3 10133.2 10168.4 15394.0 15449.5 15525.8 15580.5 15684.2 6808.7 6984.6 6995.3 6995.7 7068.5 3780.1 3787.9 3793.5 3851.2 3881.8 2849.7 2871.3 2873.9 2880.8 2884.8 492.3 506.8 511.7 527.9 547.9 542.7 564.6 573.6 574.3 580.1 6938.3 7034.2 7251.1 7401.3 7564.1 552.2 560.2 569.3 570.3 577.6 3375.5 3494.7 3545.6 3585.2 3666.5 47301.8 47913.0 52332.7 52674.5 52754.0 40150.0 40393.0 40430.8 40564.2 41117.8 34795.1 40261.8 42851.4 43336.6 44170.3 8022.5 8132.4 8138.1 8146.8 8310.8 31412.7 32289.4 32890.0 33105.5 33293.5 41629.5 42394.0 42909.6 43033.1 43049.4 8446.0 8556.0 8612.2 8697.9 8768.8 9056.3 9172.7 9335.2 9395.6 9541.1 8776.0 8913.2 8938.9 8996.4 9057.2 8832.2 8877.2 8897.0 9018.0 9128.3 8953.9 8976.4 9152.0 9213.7 9388.6 8748.9 8798.0 8986.7 8998.1 9154.6 8622.1 8909.8 8960.9 9089.3 9210.4 07:48:54 INFO - PROCESS | 28574 | -------- Summary: end -------- 07:48:54 INFO - PROCESS | 28574 | 07:48:55 INFO - TEST-INFO | 28574: exit 0 07:48:55 INFO - TEST-OK | dromaeo_css | took 1117281ms 07:48:55 INFO - TEST-START | kraken 07:48:55 INFO - operating with platform_type : linux_ 07:48:55 INFO - Initialising browser for kraken test... 07:48:55 INFO - TEST-INFO | started process 28795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm2iVVA/profile http://localhost:57920/getInfo.html) 07:49:00 INFO - PROCESS | 28795 | __metrics Screen width/height:1600/1200 07:49:00 INFO - PROCESS | 28795 | colorDepth:24 07:49:00 INFO - PROCESS | 28795 | Browser inner width/height: 1024/697 07:49:00 INFO - PROCESS | 28795 | __metrics 07:49:01 ERROR - PROCESS | 28795 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:49:02 INFO - TEST-INFO | 28795: exit 0 07:49:02 INFO - Browser initialized. 07:49:02 INFO - Running cycle 1/1 for kraken test... 07:49:02 INFO - TEST-INFO | started process 28876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm2iVVA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:13 INFO - PROCESS | 28876 | RSS: Main: 155021312 07:49:13 INFO - PROCESS | 28876 | 07:49:16 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57920/tests/kraken/driver.html?testName=audio-beat-detection) 07:49:17 INFO - PROCESS | 28876 | RSS: Main: 195854336 07:49:17 INFO - PROCESS | 28876 | 07:49:20 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57920/tests/kraken/driver.html?testName=audio-dft) 07:49:20 INFO - PROCESS | 28876 | RSS: Main: 185851904 07:49:20 INFO - PROCESS | 28876 | 07:49:23 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57920/tests/kraken/driver.html?testName=audio-fft) 07:49:24 INFO - PROCESS | 28876 | RSS: Main: 170123264 07:49:24 INFO - PROCESS | 28876 | 07:49:26 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57920/tests/kraken/driver.html?testName=audio-oscillator) 07:49:26 INFO - PROCESS | 28876 | RSS: Main: 172879872 07:49:26 INFO - PROCESS | 28876 | 07:49:29 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57920/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:49:29 INFO - PROCESS | 28876 | RSS: Main: 173342720 07:49:29 INFO - PROCESS | 28876 | 07:49:32 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57920/tests/kraken/driver.html?testName=imaging-darkroom) 07:49:33 INFO - PROCESS | 28876 | RSS: Main: 174592000 07:49:33 INFO - PROCESS | 28876 | 07:49:37 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57920/tests/kraken/driver.html?testName=imaging-desaturate) 07:49:37 INFO - PROCESS | 28876 | RSS: Main: 170979328 07:49:37 INFO - PROCESS | 28876 | 07:49:40 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57920/tests/kraken/driver.html?testName=json-parse-financial) 07:49:41 INFO - PROCESS | 28876 | RSS: Main: 172867584 07:49:41 INFO - PROCESS | 28876 | 07:49:42 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57920/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:49:43 INFO - PROCESS | 28876 | RSS: Main: 185245696 07:49:43 INFO - PROCESS | 28876 | 07:49:45 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57920/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:49:45 INFO - PROCESS | 28876 | RSS: Main: 183549952 07:49:45 INFO - PROCESS | 28876 | 07:49:48 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57920/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:49:48 INFO - PROCESS | 28876 | RSS: Main: 190799872 07:49:48 INFO - PROCESS | 28876 | 07:49:51 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:49:51 INFO - PROCESS | 28876 | RSS: Main: 198172672 07:49:51 INFO - PROCESS | 28876 | 07:49:54 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:49:54 INFO - PROCESS | 28876 | RSS: Main: 196878336 07:49:54 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | Cycle 1(1): loaded http://localhost:57920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57920/tests/kraken/driver.html?testName=ai-astar) 07:49:56 INFO - PROCESS | 28876 | RSS: Main: 258809856 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | __start_tp_report 07:49:56 INFO - PROCESS | 28876 | _x_x_mozilla_page_load 07:49:56 INFO - PROCESS | 28876 | _x_x_mozilla_page_load_details 07:49:56 INFO - PROCESS | 28876 | |i|pagename|runs| 07:49:56 INFO - PROCESS | 28876 | |0;ai-astar;112;114;111;115;115;114;103;113;113;113 07:49:56 INFO - PROCESS | 28876 | |1;audio-beat-detection;164;134;165;175;136;159;158;135;178;148 07:49:56 INFO - PROCESS | 28876 | |2;audio-dft;163;162;163;161;163;163;162;163;162;162 07:49:56 INFO - PROCESS | 28876 | |3;audio-fft;74;74;105;112;75;73;74;116;111;75 07:49:56 INFO - PROCESS | 28876 | |4;audio-oscillator;94;95;139;96;94;96;143;95;94;142 07:49:56 INFO - PROCESS | 28876 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 07:49:56 INFO - PROCESS | 28876 | |6;imaging-darkroom;148;147;154;148;149;147;146;146;147;146 07:49:56 INFO - PROCESS | 28876 | |7;imaging-desaturate;97;97;97;96;95;95;95;96;96;95 07:49:56 INFO - PROCESS | 28876 | |8;json-parse-financial;65;66;65;66;71;68;68;77;66;66 07:49:56 INFO - PROCESS | 28876 | |9;json-stringify-tinderbox;65;65;64;64;64;64;65;64;65;65 07:49:56 INFO - PROCESS | 28876 | |10;stanford-crypto-aes;83;83;84;84;85;84;83;81;83;84 07:49:56 INFO - PROCESS | 28876 | |11;stanford-crypto-ccm;126;118;129;116;120;136;131;126;128;119 07:49:56 INFO - PROCESS | 28876 | |12;stanford-crypto-pbkdf2;145;131;141;139;140;129;140;142;142;143 07:49:56 INFO - PROCESS | 28876 | |13;stanford-crypto-sha256-iterative;70;69;69;71;67;67;68;66;65;66 07:49:56 INFO - PROCESS | 28876 | __end_tp_report 07:49:56 INFO - PROCESS | 28876 | __start_cc_report 07:49:56 INFO - PROCESS | 28876 | _x_x_mozilla_cycle_collect,1204 07:49:56 INFO - PROCESS | 28876 | __end_cc_report 07:49:56 INFO - PROCESS | 28876 | __startTimestamp1459781396922__endTimestamp 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | ------- Summary: start ------- 07:49:56 INFO - PROCESS | 28876 | Number of tests: 14 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:3.50 (3.1%) stddev-sans-first:3.71 07:49:56 INFO - PROCESS | 28876 | Values: 112.0 114.0 111.0 115.0 115.0 114.0 103.0 113.0 113.0 113.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:161.50 stddev:16.28 (10.1%) stddev-sans-first:16.95 07:49:56 INFO - PROCESS | 28876 | Values: 164.0 134.0 165.0 175.0 136.0 159.0 158.0 135.0 178.0 148.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 07:49:56 INFO - PROCESS | 28876 | Values: 163.0 162.0 163.0 161.0 163.0 163.0 162.0 163.0 162.0 162.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#3] audio-fft Cycles:10 Average:88.90 Median:74.00 stddev:19.21 (26.0%) stddev-sans-first:19.60 07:49:56 INFO - PROCESS | 28876 | Values: 74.0 74.0 105.0 112.0 75.0 73.0 74.0 116.0 111.0 75.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:94.50 stddev:22.48 (23.8%) stddev-sans-first:23.20 07:49:56 INFO - PROCESS | 28876 | Values: 94.0 95.0 139.0 96.0 94.0 96.0 143.0 95.0 94.0 142.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:49:56 INFO - PROCESS | 28876 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:2.39 (1.6%) stddev-sans-first:2.54 07:49:56 INFO - PROCESS | 28876 | Values: 148.0 147.0 154.0 148.0 149.0 147.0 146.0 146.0 147.0 146.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 07:49:56 INFO - PROCESS | 28876 | Values: 97.0 97.0 97.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:67.00 stddev:3.71 (5.5%) stddev-sans-first:3.79 07:49:56 INFO - PROCESS | 28876 | Values: 65.0 66.0 65.0 66.0 71.0 68.0 68.0 77.0 66.0 66.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 07:49:56 INFO - PROCESS | 28876 | Values: 65.0 65.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 07:49:56 INFO - PROCESS | 28876 | Values: 83.0 83.0 84.0 84.0 85.0 84.0 83.0 81.0 83.0 84.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:127.00 stddev:6.45 (5.1%) stddev-sans-first:6.83 07:49:56 INFO - PROCESS | 28876 | Values: 126.0 118.0 129.0 116.0 120.0 136.0 131.0 126.0 128.0 119.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.20 Median:141.50 stddev:5.16 (3.6%) stddev-sans-first:5.03 07:49:56 INFO - PROCESS | 28876 | Values: 145.0 131.0 141.0 139.0 140.0 129.0 140.0 142.0 142.0 143.0 07:49:56 INFO - PROCESS | 28876 | 07:49:56 INFO - PROCESS | 28876 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.93 (2.8%) stddev-sans-first:1.88 07:49:56 INFO - PROCESS | 28876 | Values: 70.0 69.0 69.0 71.0 67.0 67.0 68.0 66.0 65.0 66.0 07:49:56 INFO - PROCESS | 28876 | -------- Summary: end -------- 07:49:56 INFO - PROCESS | 28876 | 07:49:57 INFO - TEST-INFO | 28876: exit 0 07:49:57 INFO - TEST-OK | kraken | took 62205ms 07:49:57 INFO - SUITE-END | took 1179s 07:49:58 INFO - Completed test suite (00:19:39) 07:49:58 INFO - javascript benchmark 07:49:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2583.793296536277, 2634.078072674563, 2657.747513986171, 2681.6379788728514, 2682.3830518980635, 4447.955520444794, 4488.910221795562, 4519.0, 4522.231220692482, 4564.817407303713, 4429.60133587977, 4503.527129651388, 4520.412346394964, 4578.427696537933, 4622.168009758242, 4208.684348673846, 4210.6631469482445, 4264.253755592775, 4278.7218830776055, 4353.25994580922, 4279.914401711964, 4296.828126874937, 4315.935260971088, 4355.5644435556505, 4357.12857428514, 4155.542890282067, 4165.500139983191, 4224.366345048236, 4233.089885674564, 4248.341507066394, 4175.5615660355525, 4186.162767446523, 4224.38746381776, 4240.342746874239, 4280.400743895857, 4147.39862719907, 4176.958230417687, 4214.283571792803, 4226.260404429213, 4248.808803603845, 4358.847440339573, 4415.492218394861, 4457.130859482402, 4469.083837813273, 4512.503624601291, 4818.132736107499, 4826.927596086061, 4834.081524510332, 4859.0, 4874.195757699975, 4851.878703032417, 4856.732879691615, 4864.513548645143, 4867.269909513566, 4918.9754051229875, 4529.796159172845, 4591.484810012687, 4597.770111494412, 4657.580817726353, 4680.040591678698, 5011.824586139541, 5016.623753218523, 5020.0, 5035.068512325159, 5059.19052951526, 4790.377250957354, 4810.350602668665, 4813.7593120343845, 4817.325574419584, 4859.586935110485, 4799.0401919616215, 4865.56209941107, 4905.583025442806, 4940.431850337257, 4958.429780575208, 4841.080194763054, 4853.102176097434, 4856.247281671276, 4871.29366241893, 4907.092187945242, 4740.265258884879, 4846.830360937421, 4848.7090774553635, 4865.172920603506, 4909.2881532177635, 4206.684498662613, 4240.427542281815, 4244.596763307481, 4278.743275403485, 4316.762578058237, 3604.7296452766145, 3616.945745813815, 3628.9092772680365, 3655.3785856403942, 3656.305301992613, 4160.079296245818, 4161.479815023122, 4167.270727622654, 4169.56219596944, 4221.430106935524, 4840.903181936342, 4877.146499362598, 4944.75276236194, 4983.377077865267, 5007.524285192901, 4174.645155161846, 4239.300515414922, 4242.4272723181975, 4243.384709217146, 4270.935935960963, 4343.891402714894, 4470.848052123245, 4509.057528150421, 4510.1656193604285, 4537.296719008559, 4651.534846515321, 4694.530546945278, 4706.0823139487475, 4748.264019077049, 4749.287606859068, 4848.9757551212015, 4858.82994095205, 4861.173600487855, 4861.611071114232, 4889.144399729962, 4537.137943790669, 4568.908621827612, 4617.699849509771, 4620.976895115503, 4667.83662571822, 4833.540813622841, 4834.419869615528, 4850.5149485052625, 4861.173600487855, 4904.190808516555, 4877.244027175793, 4898.142825005681, 4922.72924989129, 4925.581325587222, 4940.2342636891335, 4675.111728771522, 4733.242681170997, 4780.235162374003, 4795.136875362468, 4809.879753006203, 4745.477997420212, 4759.381280433521, 4763.095011947719, 4790.7844147012775, 4824.927626085681, 4729.314249433882, 4733.029728905635, 4748.62011039123, 4771.78319528518, 4782.163121453662, 4610.792514336796, 4636.60588849938, 4692.038132182963, 4735.715857048588, 4814.133455977818, 4542.568455996675, 4554.544545545551, 4559.475660299108, 4680.789364478538, 4746.240601503743], "unit": "score", "name": "dojo.html", "value": 4498.942826987061}, {"lowerIsBetter": false, "replicates": [514.2671692837706, 522.7386306846577, 524.8373004368649, 538.9649672771268, 558.0206737176255, 34240.65759342406, 34582.8270858646, 34862.65137348626, 34930.12674683131, 35022.64977350226, 37839.621603783955, 38971.22057558847, 38973.61026389735, 39009.0, 39029.609703902956, 7757.883631745528, 7931.246531579491, 7936.642851071716, 7944.165862584432, 7953.284204421601, 7628.0, 7827.960860195691, 7872.0, 7886.29023387895, 7895.486793358414, 7885.566293853835, 7993.2806047455715, 7994.0, 8004.079530853968, 8008.519488830689, 7784.455088143832, 7898.881516777195, 7948.244916732901, 7952.244536768998, 7953.4432589718745, 7843.6470358833985, 7971.441999060068, 7980.082290536547, 7981.920180798175, 7986.161453047463, 35311.646883531095, 35445.29109417823, 35711.4643280351, 35740.82129589361, 35754.82122589397, 2183.5087105401317, 2286.897089630954, 2898.231968528342, 2952.7047295270518, 3092.3815236952473, 26050.609240861402, 26206.344841378927, 26310.73689263102, 26610.201693949213, 26990.325241868915, 3146.9685303146903, 3184.8407579620925, 3216.1477208539754, 3283.3269179818317, 3358.647342029101, 165527.9999999988, 165570.0, 165608.0, 165645.0, 165914.0, 48100.27849582259, 48239.0, 48360.5163948356, 48546.514534854905, 48548.27177592339, 58650.41349586449, 60258.39741602616, 60335.69832150899, 60375.39624603698, 60614.39385606175, 13940.0, 14072.437102515785, 14227.644308892153, 14264.857351426353, 14278.785818212735, 10882.075023622923, 11035.172362072877, 11040.171987101, 11072.778544429066, 11077.224594278323, 18438.35465758692, 18534.44396668102, 18637.254509819726, 19212.71180932287, 19237.61524769525, 6823.215330236987, 6872.41584465326, 7019.8596028079155, 7022.0, 7103.680334384965, 827.3174630929507, 835.5863847395457, 865.6104752861238, 872.1845074855031, 899.8920129584492, 26823.26909209443, 27129.728702713113, 27299.31751706223, 27515.724842751715, 27519.31201719933, 980.5342462330336, 1028.840529717895, 1031.4945676618404, 1043.9895601044045, 1052.0, 14311.57065288043, 14578.562643120724, 14639.0, 14778.48275310359, 14904.329305181293, 353543.0, 358273.0, 358949.0, 358960.0, 359150.0, 48358.0, 49593.25610115851, 49717.0, 49878.750606247464, 50089.74955125201, 1112.1547623805966, 1210.0863847794858, 1210.6247063410372, 1223.174357308813, 1244.153975296807, 25465.363365916, 25803.936464778377, 25991.74008259893, 26091.478170436865, 27975.440491190468, 39959.60040399559, 40207.396889047275, 40464.3930341051, 40580.1883962325, 40586.0, 228827.0, 229721.0, 230229.0, 230254.0, 230499.0, 33035.0, 33895.66104339024, 38557.42163867488, 39470.60529394669, 39548.40677389784, 36427.27145457023, 37664.0, 37760.62239377571, 40887.386689200284, 40982.0, 34377.484337735455, 34417.0, 34624.0, 34995.0, 35200.0, 34194.658053419145, 34358.0, 34446.48330274998, 34476.482852757734, 34939.0, 34518.65481345155, 34537.48193777146, 34861.12847178841, 35224.0, 35985.640143598226, 28249.717502824707, 30437.847810760806, 30510.694893050786, 30597.54103688491, 30887.536686949265, 24172.274831755076, 24208.376911200477, 24494.877525612257, 24713.752862471145, 24750.876245619376], "unit": "score", "name": "ext.html", "value": 16854.03459410149}, {"lowerIsBetter": false, "replicates": [342.21803179734314, 344.8379261746978, 348.626969143017, 353.79479901657044, 354.06350203711185, 14599.927000364996, 15573.766393504107, 15888.126153061577, 15901.443449479271, 16122.193890305482, 16346.509604711848, 16454.095024773633, 16571.751423728652, 16800.579985500368, 17011.65976680469, 4791.897863491399, 4832.4442689090765, 4974.10466116099, 4981.2030075187795, 5022.497750224985, 4822.614190864722, 4889.853304400855, 4923.0, 4923.77842997066, 4926.211806111023, 4882.584980276681, 4889.535494128052, 4890.144224760653, 4901.558859702626, 4920.163572192736, 4892.461829198785, 5566.805161819337, 5796.188533605298, 5803.941960580382, 5806.767729290823, 5159.529534082769, 5164.535191832753, 5165.121929271995, 5177.275181474596, 5178.741062946838, 12343.5062597496, 18797.436076917576, 18848.5287867803, 18897.716534252, 18906.338278160198, 1791.4715159027987, 1801.8558515318744, 1825.470613522077, 1836.623492184099, 1842.8709990300683, 9271.0, 9393.812123757487, 9699.563519641633, 11804.527818887234, 13234.66913327165, 1745.127436281859, 1765.7881054273441, 1774.8225177482277, 1778.644271145763, 1795.8204179581937, 54274.72862635701, 60178.0, 61437.69281153566, 61903.38096619021, 62802.0, 9406.71779846592, 9486.0, 9537.093976072261, 9568.76078098053, 9642.132208101304, 13022.739545209042, 13142.60572182836, 13165.407556659782, 13171.341432928315, 13178.364327134612, 6986.825329366705, 7031.08595882532, 7046.1192350956135, 7081.752138675121, 7146.392556632641, 6599.010148477671, 6601.3068627794355, 6828.5902845829405, 6837.982795075464, 6971.651417429108, 3923.1172986078473, 3980.5422376426504, 4112.856050038235, 4158.397032430341, 4238.788060596958, 1761.9911900440416, 1767.45208985215, 1791.4536066499843, 1791.739034956393, 1800.4598620413824, 785.3795501553823, 839.9748007559783, 863.218786997768, 876.5529579914162, 922.686286662538, 15441.922790386201, 16136.515904522883, 16209.513714588582, 16211.351545938267, 16302.429414970418, 837.2966707965338, 871.5598622695499, 873.4715497124275, 890.3544929925881, 921.0329154387999, 9043.77390565228, 9109.77225569366, 9221.446713197229, 9465.432074075577, 9576.281778866613, 370542.0, 372930.0, 375032.0, 377357.0, 377470.0, 66556.66721666457, 70709.0, 73559.63220183972, 74699.0, 75256.62371688106, 980.563649176124, 991.0931497679686, 1015.4110615842793, 1039.8076355874186, 1046.4715318763976, 14207.857921420653, 14773.670369666352, 15025.173615450818, 15255.466058687893, 15405.229738512806, 30502.542461862646, 31084.68915310818, 31262.843685781427, 33417.83291083529, 34799.710484938136, 44130.33804492871, 44396.778016111006, 44490.3326450097, 44496.33255501105, 44928.0, 7444.478886477895, 7654.2345765423015, 7677.424193185645, 7679.846403072019, 7746.457747957589, 10422.478876056015, 11429.371384573597, 11454.541818327174, 11653.242539234923, 11694.824577631172, 5544.057510223352, 7144.535605185646, 9902.009799020329, 10108.39349639024, 10191.490425478549, 9651.324407291422, 9872.950635246778, 10029.398236105566, 10076.69769906904, 10214.285000049926, 9989.650362237287, 10066.295359324777, 10186.49067546605, 10353.585856565955, 10518.842217366899, 7281.890771638324, 7405.0, 7579.5073320234005, 7617.390608751398, 7711.652975616223, 7487.700491980259, 8843.690470833748, 9782.070703283176, 10559.577616895545, 10643.680689579325], "unit": "score", "name": "jquery.html", "value": 7862.880704775999}, {"lowerIsBetter": false, "replicates": [1300.6488248173, 1384.6399936016635, 1425.2588653899968, 1538.9692206155878, 1738.852197563207, 6922.792316230509, 7097.680604372803, 7099.751508697196, 7108.822279443017, 7116.964415177923, 6980.511364204508, 7099.325564071405, 7117.252688467701, 7172.282771722825, 7177.3540381365665, 1845.713914343279, 2147.38799442159, 2167.143978128638, 2195.978040219601, 2204.64725643897, 2201.38361258847, 2213.4134454369605, 2216.434809123671, 2222.688823564702, 2226.9665955010687, 2113.957720845582, 2197.7582465928735, 2200.801927826495, 2201.2625770366944, 2201.6147174244525, 2180.062573093569, 2198.5492973940386, 2204.2064856651673, 2224.3882932193615, 2229.4537838229576, 2192.78072192781, 2197.9120835166573, 2201.9449513762124, 2202.7136472258503, 2203.31697173875, 7274.854502909965, 7382.741604043833, 7403.0, 7414.073240844895, 7426.962865185694, 4274.957250427487, 4400.471943366784, 4415.183191109655, 4417.580329868657, 4421.314696222091, 2817.2393453767368, 2886.350571121502, 2924.517454619985, 2937.9265518362, 2939.544370622557, 976.038601977052, 988.6737376665754, 1000.1198944928417, 1005.9497025148713, 1023.247912784103, 9830.410175389428, 9839.86841513228, 9849.90150098497, 9855.802883942353, 9904.653337133166, 3943.7042221833476, 4029.5768944261017, 4102.097538541516, 4124.52567954683, 4136.9793151034655, 8461.873071903927, 8590.269827064645, 8594.699185528476, 8644.351673624504, 8650.307975361957, 3729.21686445844, 4466.307722302983, 4473.776311184428, 4494.505604383515, 4497.2129877271345, 3914.2171565686976, 3943.0536671198706, 3972.5232972042963, 3978.781167035841, 3989.082511022423, 3357.1439282982683, 3424.2466657335344, 3427.862885484553, 3453.723702103826, 3455.4125798614295, 1135.1769966774023, 1139.840422340873, 1145.1068166829718, 1148.5061423587938, 1155.9595414160465, 1154.8960593546622, 1166.836642869999, 1177.7232350397649, 1188.477070089158, 1199.6161228406827, 6552.6068435894, 6590.736370545124, 6590.7693230736695, 6605.042268870987, 6690.565113267719, 995.5470261031213, 1013.1287093099928, 1037.4345981440133, 1044.7597052677927, 1060.8620879285643, 5328.786848526015, 5333.5199832015305, 5336.359636843604, 5389.946100539023, 5392.973035134799, 8239.876401853977, 8847.823043539092, 8951.194392504705, 9005.279577633904, 9057.139571740674, 8809.955950220336, 8818.0, 8851.64593416269, 8871.112888711206, 8890.688825891062, 6597.175353080865, 6830.624315662587, 6848.554843935228, 6865.965670171717, 7000.789976300719, 6680.3987641112535, 6694.062831203538, 6713.597184168965, 6715.462762978852, 6728.428083612752, 7758.61206939662, 8049.919500804917, 8085.716999904975, 8215.876761848458, 8234.505929644241, 8272.710455134042, 8509.574521273787, 8517.44636598619, 8524.74425767228, 8541.487510749375, 6092.116643086816, 6277.1525844010475, 6278.968605156945, 6283.403076707706, 6301.6219026858535, 6804.727810887509, 6804.761833336008, 6846.5892046477375, 6866.759663411756, 6873.862522749617, 6061.212042434456, 6200.3799620037635, 6267.2165979252595, 6307.842303942254, 6347.270063942706, 6129.601575897553, 6171.413715697002, 6213.161223234805, 6302.810915672354, 6328.968355158195, 6317.305096439296, 6320.5891617044745, 6331.398517140864, 6336.778212762531, 6343.429091381798, 5873.588848780715, 5885.852853678693, 5910.881782364415, 5927.881442371215, 5948.048312270016, 6106.877862442815, 6148.569600127948, 6152.0156774915795, 6157.907631385443, 6166.845828854314], "unit": "score", "name": "mootools.html", "value": 4218.758531729133}, {"lowerIsBetter": false, "replicates": [284.72097344602287, 287.70222819381945, 290.25404709895565, 290.9607203027591, 294.35829890837977, 5248.868778280545, 5250.976059668362, 5252.054630166574, 5260.0268950244235, 5266.736663166836, 5006.12392831254, 5155.974220128904, 5168.121419358708, 5180.8704782380455, 5202.271681964518, 3805.84969492236, 3958.366661334187, 4014.939775903371, 4027.8791636250958, 4049.7975101244965, 4052.533958594755, 4058.330375488056, 4080.5511393746665, 4081.755094694313, 4094.160697057111, 4048.696347773914, 4059.63463288304, 4060.8984775380554, 4068.8575899843363, 4075.368317910714, 3853.9614603854025, 3938.9015274618077, 4016.0763024504236, 4024.2957482440456, 4026.7583944963394, 3540.628234035415, 3550.0769799851964, 3551.698105661022, 3554.3957527220437, 3556.110972256936, 4876.341693871317, 4883.145449546315, 4948.406191257036, 4950.554450099472, 4969.602431805483, 4660.300954856764, 4661.067786442691, 4661.976690116528, 4667.533246675339, 4681.993371425126, 5379.596530260207, 5424.647397919122, 5468.91796623051, 5488.670679759187, 5502.339719233678, 3868.825902834351, 3873.0511024798825, 3877.0, 3949.269385163754, 3950.071733142709, 5465.316835395575, 5598.412166722476, 5716.114002329646, 5727.684977326246, 5759.3376761672525, 3872.9419058714143, 3884.941725874114, 3896.902577435587, 3897.0647044709067, 3909.4135879617716, 3945.881623551298, 3945.921081578352, 3950.0322421007036, 3953.367461206193, 3956.3669812829808, 4565.931511027337, 4567.931481027787, 4567.931481027787, 4576.679632425765, 4577.22187228172, 5485.588580856452, 5486.588505862076, 5489.698066606375, 5492.615516913777, 5494.780208791683, 1406.2406300597768, 1423.8647328503775, 1424.4658253155067, 1425.4013314407973, 1425.7433661940743, 900.6577500549749, 944.0696979851047, 945.1729736480579, 972.3825370889394, 993.3543196922059, 4719.622430205575, 4762.261849413347, 4780.306855505932, 4784.665073444895, 4791.5687588117235, 5619.353774316006, 5623.268975033219, 5623.578231632644, 5632.9436705632415, 5636.85907852307, 4783.617310615212, 4783.808647654055, 4785.210440277316, 4792.041591681677, 4792.640551958617, 2991.341904780945, 3017.969820301769, 3019.154636701727, 3022.199117233935, 3028.2732144285214, 5339.919901201485, 5343.465653434703, 5345.7815006772535, 5346.144616861284, 5357.7589008494715, 5651.350094739076, 5751.884962300731, 5838.328592211865, 5877.5591830612875, 5889.94110058894, 5399.622026458189, 5420.701861397661, 5432.402435732066, 5440.455954404528, 5448.991936491761, 5695.943040569541, 5696.316442026983, 5697.886042279214, 5710.914336285042, 5712.371639119777, 5587.664740115606, 5589.217509548747, 5595.63628364155, 5606.0, 5618.578606604439, 5415.972920135374, 5427.0, 5440.836774896601, 5443.401225865073, 5443.836684899459, 3772.9434058488596, 3867.8839634811, 3875.147467557133, 3879.80600969956, 3893.2018936118593, 5641.943580564306, 5659.830205093854, 5679.9432005681065, 5690.5163061140265, 5691.8861622768145, 5464.153056276284, 5470.480304371078, 5475.151351540518, 5479.835604931858, 5480.123180291134, 5421.457854214547, 5473.179023146401, 5481.287432633732, 5482.068048431696, 5493.066178749542, 5408.8377348679605, 5409.486098820763, 5417.972910135424, 5419.810306639406, 5421.0513160196015, 5356.7589458473685, 5521.171824226398, 5540.168974653834, 5544.805931792368, 5545.029619816597, 5337.332833395825, 5376.064616737893, 5389.380221274603, 5407.459254074561, 5414.835810300647], "unit": "score", "name": "prototype.html", "value": 4109.6078626879835}, {"lowerIsBetter": false, "replicates": [616.5499185594516, 624.6907780648577, 647.9060536222248, 651.4007113455621, 750.500916890268, 10988.120950323975, 11108.888911110886, 11112.944435277823, 11150.553977840877, 11167.441627918612, 11039.889601103987, 11121.72195695108, 11162.497687604056, 11240.662780116589, 11264.605738799144, 801.603206412825, 819.8073452738602, 820.4625969989637, 820.7906983719143, 820.9548474833882, 808.49873078691, 816.3713940265992, 816.8325493273894, 816.8529664660359, 818.9918100818975, 847.3814115695546, 851.833892390984, 852.8209076094028, 853.3002937591177, 853.6286715278843, 853.7780177153953, 853.7950891785957, 853.9829203415896, 854.8888644476209, 854.974350769478, 625.9311475737666, 626.2829060725444, 627.2848952194502, 627.6987046217795, 627.8775638750445, 10229.0, 10256.33333833306, 10269.0, 10269.640562580349, 10280.177585793193, 10168.288219824615, 10250.7437314067, 10646.201534884915, 10865.51105200268, 10932.56269749209, 8001.479903806234, 8166.358723381111, 8186.222308880647, 8357.916420835774, 8663.610137543825, 3214.228585139573, 3240.756943229267, 3308.801471911669, 3344.7491438142238, 3382.374260761767, 37972.62027379746, 39358.21283574341, 40699.09863069868, 40801.1839763206, 42433.151336973395, 9769.90230097704, 10015.39907605546, 10067.295289329822, 10133.189344852393, 10168.389896606228, 15394.0, 15449.459268925533, 15525.767113493306, 15580.532584022498, 15684.215789210493, 6808.7276508939085, 6984.61584612841, 6995.265497122728, 6995.720171193096, 7068.539214716605, 3780.0738818988975, 3787.867424640124, 3793.5447746270625, 3851.2105018471707, 3881.7865017423746, 2849.6865344812054, 2871.296532349546, 2873.8563071846324, 2880.812747171427, 2884.7980641355325, 492.31568120312795, 506.8200788719951, 511.7236692186252, 527.8785879247795, 547.8520799384144, 542.7096503370677, 564.5596434780878, 573.5927491481011, 574.2792795042195, 580.1066357809011, 6938.340857618518, 7034.166662524097, 7251.1298644163035, 7401.296876796696, 7564.0923089228545, 552.1800126811762, 560.2129008742723, 569.2571194591015, 570.2785975740692, 577.5841394196173, 3375.493675948578, 3494.650534946485, 3545.62770909056, 3585.2112535242204, 3666.450032495147, 47301.763491182326, 47913.0, 52332.73833630807, 52674.47325526772, 52754.0, 40150.0, 40393.0, 40430.79784601058, 40564.18871622551, 41117.79441102775, 34795.13012174665, 40261.798691006356, 42851.35722964158, 43336.566634333256, 44170.33744493835, 8022.478538895187, 8132.390070744599, 8138.145494722969, 8146.83706325882, 8310.750677479686, 31412.685873140977, 32289.35421291514, 32890.0, 33105.50341744828, 33293.50059749057, 41629.46149577199, 42394.0, 42909.57090429181, 43033.13933721371, 43049.354259686756, 8446.0, 8556.0, 8612.224899759052, 8697.8695319569, 8768.824623507622, 9056.320775941962, 9172.6789562365, 9335.159835614828, 9395.577199026196, 9541.141297283279, 8776.0, 8913.153250441197, 8938.910610893809, 8996.43260419884, 9057.230135438562, 8832.226333229188, 8877.156670116328, 8897.0, 9017.954910225408, 9128.256015876954, 8953.865692014495, 8976.41653292534, 9152.0, 9213.723588292361, 9388.57751401175, 8748.862647855738, 8798.0, 8986.68546600866, 8998.14517620825, 9154.633814647606, 8622.094680058755, 8909.777255568662, 8960.910390896008, 9089.31830112731, 9210.447373157633], "unit": "score", "name": "yui.html", "value": 5562.340866828513}], "name": "dromaeo_css", "value": 6212.702838556644}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 111.0, 115.0, 115.0, 114.0, 103.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [164.0, 134.0, 165.0, 175.0, 136.0, 159.0, 158.0, 135.0, 178.0, 148.0], "unit": "score", "name": "audio-beat-detection", "value": 155.2}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 161.0, 163.0, 163.0, 162.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 105.0, 112.0, 75.0, 73.0, 74.0, 116.0, 111.0, 75.0], "unit": "score", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 139.0, 96.0, 94.0, 96.0, 143.0, 95.0, 94.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 154.0, 148.0, 149.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 66.0, 71.0, 68.0, 68.0, 77.0, 66.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 67.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 84.0, 85.0, 84.0, 83.0, 81.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [126.0, 118.0, 129.0, 116.0, 120.0, 136.0, 131.0, 126.0, 128.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [145.0, 131.0, 141.0, 139.0, 140.0, 129.0, 140.0, 142.0, 142.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 71.0, 67.0, 67.0, 68.0, 66.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1536.0000000000002}]} 07:49:58 INFO - Return code: 0 07:49:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:49:58 ERROR - # TBPL SUCCESS # 07:49:58 INFO - Running post-action listener: _resource_record_post_action 07:49:58 INFO - Running post-run listener: _resource_record_post_run 07:49:59 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 2334720; Write bytes: 519487488; Read time: 680; Write time: 539612 07:49:59 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233205760; Read time: 0; Write time: 320920 07:49:59 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 2334720; Write bytes: 286281728; Read time: 680; Write time: 218692 07:49:59 INFO - Running post-run listener: _upload_blobber_files 07:49:59 INFO - Blob upload gear active. 07:49:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:49:59 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 07:49:59 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'] 07:49:59 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 07:50:00 INFO - (blobuploader) - INFO - Open directory for files ... 07:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:50:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:01 INFO - (blobuploader) - INFO - Done attempting. 07:50:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:50:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:50:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:03 INFO - (blobuploader) - INFO - Done attempting. 07:50:03 INFO - (blobuploader) - INFO - Iteration through files over. 07:50:03 INFO - Return code: 0 07:50:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:50:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:50:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ebb9ead2e92f0de2909d8cf8d7f99191390d5dcdea5331f49912b219adca21e65fe0868ee0a66c6bbbe09940519edd0dca553ed0930c2f21a6bc2a1d0a42928b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85b8e6247c220cf1651354769078c4072db23a303b46a93d5ef598c4c3a28584ec84bf3481a8bc2a3eb807899625d7f4ce979c92d5eee81d384c8515cda14737"} 07:50:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:50:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:50:03 INFO - Contents: 07:50:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ebb9ead2e92f0de2909d8cf8d7f99191390d5dcdea5331f49912b219adca21e65fe0868ee0a66c6bbbe09940519edd0dca553ed0930c2f21a6bc2a1d0a42928b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85b8e6247c220cf1651354769078c4072db23a303b46a93d5ef598c4c3a28584ec84bf3481a8bc2a3eb807899625d7f4ce979c92d5eee81d384c8515cda14737"} 07:50:03 INFO - Running post-run listener: copy_logs_to_upload_dir 07:50:03 INFO - Copying logs to upload dir... 07:50:03 INFO - mkdir: /builds/slave/test/build/upload/logs 07:50:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.088385 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-04 07:50:01.581735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 07:50:01.585711) ========= 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=52faae308a556c440401f8e5000001e8-1459779712.671307-520526182 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/ebb9ead2e92f0de2909d8cf8d7f99191390d5dcdea5331f49912b219adca21e65fe0868ee0a66c6bbbe09940519edd0dca553ed0930c2f21a6bc2a1d0a42928b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85b8e6247c220cf1651354769078c4072db23a303b46a93d5ef598c4c3a28584ec84bf3481a8bc2a3eb807899625d7f4ce979c92d5eee81d384c8515cda14737"} build_url:https://queue.taskcluster.net/v1/task/AOygN67xTmqMIC7A6daf-Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/AOygN67xTmqMIC7A6daf-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/ebb9ead2e92f0de2909d8cf8d7f99191390d5dcdea5331f49912b219adca21e65fe0868ee0a66c6bbbe09940519edd0dca553ed0930c2f21a6bc2a1d0a42928b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85b8e6247c220cf1651354769078c4072db23a303b46a93d5ef598c4c3a28584ec84bf3481a8bc2a3eb807899625d7f4ce979c92d5eee81d384c8515cda14737"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 07:50:01.610609) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 07:50:01.610962) ========= 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=52faae308a556c440401f8e5000001e8-1459779712.671307-520526182 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004701 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 07:50:01.693295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 07:50:01.693619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 07:50:01.693951) ========= ========= Total master_lag: 0.31 =========