builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-044 starttime: 1459941691.97 results: success (0) buildid: 20160406025815 builduid: 5b860b91b71b4be5b877287c3035aa4c revision: 05ce1f2670ae52e928af76df72e78989935141e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:31.966609) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:31.967135) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:31.967427) ========= 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=574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006440 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:31.990905) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:31.991242) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.016653) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.016919) ========= 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=574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.065219) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.065478) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.065808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.066077) ========= 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=574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-06 04:21:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 81.6M=0s 2016-04-06 04:21:32 (81.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170032 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.248097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.248407) ========= 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=574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019373 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.298553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.298977) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05ce1f2670ae52e928af76df72e78989935141e3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 05ce1f2670ae52e928af76df72e78989935141e3 --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=574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-06 04:21:32,389 truncating revision to first 12 chars 2016-04-06 04:21:32,389 Setting DEBUG logging. 2016-04-06 04:21:32,389 attempt 1/10 2016-04-06 04:21:32,389 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05ce1f2670ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 04:21:32,710 unpacking tar archive at: mozilla-central-05ce1f2670ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586166 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.898085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.898435) ========= echo 05ce1f2670ae52e928af76df72e78989935141e3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'05ce1f2670ae52e928af76df72e78989935141e3'] 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=574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05ce1f2670ae52e928af76df72e78989935141e3 program finished with exit code 0 elapsedTime=0.004264 script_repo_revision: '05ce1f2670ae52e928af76df72e78989935141e3' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.947435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.947754) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 04:21:32.957932) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-06 04:21:32.958214) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:21:33 INFO - MultiFileLogger online at 20160406 04:21:33 in /builds/slave/test 04:21:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:21:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:21:33 INFO - {'append_to_log': False, 04:21:33 INFO - 'base_work_dir': '/builds/slave/test', 04:21:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:21:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:21:33 INFO - 'branch': 'Firefox-Non-PGO', 04:21:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:21:33 INFO - 'config_files': ('talos/linux_config.py',), 04:21:33 INFO - 'default_actions': ('clobber', 04:21:33 INFO - 'read-buildbot-config', 04:21:33 INFO - 'download-and-extract', 04:21:33 INFO - 'populate-webroot', 04:21:33 INFO - 'create-virtualenv', 04:21:33 INFO - 'install', 04:21:33 INFO - 'run-tests'), 04:21:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:21:33 INFO - 'download_minidump_stackwalk': True, 04:21:33 INFO - 'download_symbols': 'ondemand', 04:21:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:21:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:21:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:21:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:21:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:21:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:21:33 INFO - 'installer_path': 'installer.exe', 04:21:33 INFO - 'log_level': 'info', 04:21:33 INFO - 'log_name': 'talos', 04:21:33 INFO - 'log_to_console': True, 04:21:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:21:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:21:33 INFO - 'opt_config_files': (), 04:21:33 INFO - 'pip_index': False, 04:21:33 INFO - 'sps_profile': False, 04:21:33 INFO - 'sps_profile_interval': 0, 04:21:33 INFO - 'suite': 'dromaeojs', 04:21:33 INFO - 'system_bits': '32', 04:21:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:21:33 INFO - 'title': 'talos-linux64-ix-044', 04:21:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:21:33 INFO - 'use_talos_json': True, 04:21:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:21:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:21:33 INFO - 'work_dir': 'build'} 04:21:33 INFO - ##### 04:21:33 INFO - ##### Running clobber step. 04:21:33 INFO - ##### 04:21:33 INFO - Running pre-action listener: _resource_record_pre_action 04:21:33 INFO - Running main action method: clobber 04:21:33 INFO - rmtree: /builds/slave/test/build 04:21:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:21:33 INFO - Running post-action listener: _resource_record_post_action 04:21:33 INFO - ##### 04:21:33 INFO - ##### Running read-buildbot-config step. 04:21:33 INFO - ##### 04:21:33 INFO - Running pre-action listener: _resource_record_pre_action 04:21:33 INFO - Running main action method: read_buildbot_config 04:21:33 INFO - Using buildbot properties: 04:21:33 INFO - { 04:21:33 INFO - "project": "", 04:21:33 INFO - "product": "firefox", 04:21:33 INFO - "script_repo_revision": "production", 04:21:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:21:33 INFO - "repository": "", 04:21:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:21:33 INFO - "buildid": "20160406025815", 04:21:33 INFO - "pgo_build": "False", 04:21:33 INFO - "basedir": "/builds/slave/test", 04:21:33 INFO - "buildnumber": 542, 04:21:33 INFO - "slavename": "talos-linux64-ix-044", 04:21:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:21:33 INFO - "platform": "ubuntu64_hw", 04:21:33 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:21:33 INFO - "branch": "mozilla-central", 04:21:33 INFO - "repo_path": "mozilla-central", 04:21:33 INFO - "revision": "05ce1f2670ae52e928af76df72e78989935141e3", 04:21:33 INFO - "stage_platform": "linux64", 04:21:33 INFO - "builduid": "5b860b91b71b4be5b877287c3035aa4c", 04:21:33 INFO - "slavebuilddir": "test" 04:21:33 INFO - } 04:21:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:21:33 INFO - Running post-action listener: _resource_record_post_action 04:21:33 INFO - ##### 04:21:33 INFO - ##### Running download-and-extract step. 04:21:33 INFO - ##### 04:21:33 INFO - Running pre-action listener: _resource_record_pre_action 04:21:33 INFO - Running main action method: download_and_extract 04:21:33 INFO - mkdir: /builds/slave/test/build/tests 04:21:33 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')]} 04:21:33 INFO - https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:21:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:21:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:21:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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 04:21:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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 04:21:45 INFO - Downloaded 1361 bytes. 04:21:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:21:45 INFO - Using the following test package requirements: 04:21:45 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:21:45 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:21:45 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:21:45 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:45 INFO - u'jsshell-linux-x86_64.zip'], 04:21:45 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:21:45 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:21:45 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:21:45 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:21:45 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:21:45 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:21:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:21:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:45 INFO - https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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 04:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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 04:21:51 INFO - Downloaded 22129519 bytes. 04:21:51 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'] 04:21:51 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 04:21:52 INFO - Return code: 0 04:21:52 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 04:21:52 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')]} 04:21:52 INFO - https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:21:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:21:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:21:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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 04:21:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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 04:21:55 INFO - Downloaded 22129519 bytes. 04:21:55 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'] 04:21:55 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 04:21:57 INFO - Return code: 0 04:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:57 INFO - https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:21:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:21:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:21:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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 04:21:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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 04:22:03 INFO - Downloaded 10847617 bytes. 04:22:03 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'] 04:22:03 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 04:22:03 INFO - Return code: 0 04:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:03 INFO - https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:22:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:22:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:22:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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 04:22:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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 04:22:05 INFO - Downloaded 54140222 bytes. 04:22:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:22:05 INFO - mkdir: /builds/slave/test/properties 04:22:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:05 INFO - Contents: 04:22:05 INFO - build_url:https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:22:06 INFO - Running post-action listener: _resource_record_post_action 04:22:06 INFO - Running post-action listener: set_extra_try_arguments 04:22:06 INFO - ##### 04:22:06 INFO - ##### Running populate-webroot step. 04:22:06 INFO - ##### 04:22:06 INFO - Running pre-action listener: _resource_record_pre_action 04:22:06 INFO - Running main action method: populate_webroot 04:22:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:06 INFO - '--tppagecycles', 04:22:06 INFO - '7'], 04:22:06 INFO - 'tests': ['tsvgm']}}, 04:22:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:22:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:22:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:22:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:22:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:22:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:06 INFO - 'talos_options': ['--disable-e10s'], 04:22:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:06 INFO - 'talos_options': ['--disable-e10s'], 04:22:06 INFO - 'tests': ['damp', 'tps']}, 04:22:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:06 INFO - 'tests': ['damp', 'tps']}, 04:22:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:22:06 INFO - 'tests': ['dromaeo_dom']}, 04:22:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:22:06 INFO - 'tests': ['a11yr', 04:22:06 INFO - 'ts_paint', 04:22:06 INFO - 'tpaint', 04:22:06 INFO - 'sessionrestore', 04:22:06 INFO - 'sessionrestore_no_auto_restore', 04:22:06 INFO - 'tabpaint']}, 04:22:06 INFO - 'other-e10s': {'tests': ['a11yr', 04:22:06 INFO - 'ts_paint', 04:22:06 INFO - 'tpaint', 04:22:06 INFO - 'sessionrestore', 04:22:06 INFO - 'sessionrestore_no_auto_restore', 04:22:06 INFO - 'tabpaint']}, 04:22:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:22:06 INFO - 'ts_paint', 04:22:06 INFO - 'tpaint', 04:22:06 INFO - 'sessionrestore', 04:22:06 INFO - 'sessionrestore_no_auto_restore', 04:22:06 INFO - 'tabpaint']}, 04:22:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:22:06 INFO - 'ts_paint', 04:22:06 INFO - 'tpaint', 04:22:06 INFO - 'sessionrestore', 04:22:06 INFO - 'sessionrestore_no_auto_restore', 04:22:06 INFO - 'tabpaint']}, 04:22:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:22:06 INFO - 'tests': ['a11yr', 04:22:06 INFO - 'ts_paint', 04:22:06 INFO - 'tpaint', 04:22:06 INFO - 'sessionrestore', 04:22:06 INFO - 'sessionrestore_no_auto_restore', 04:22:06 INFO - 'tabpaint']}, 04:22:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:22:06 INFO - 'tests': ['a11yr', 04:22:06 INFO - 'ts_paint', 04:22:06 INFO - 'tpaint', 04:22:06 INFO - 'sessionrestore', 04:22:06 INFO - 'sessionrestore_no_auto_restore', 04:22:06 INFO - 'tabpaint']}, 04:22:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:22:06 INFO - 'tests': ['tsvgx', 04:22:06 INFO - 'tsvgr_opacity', 04:22:06 INFO - 'tart', 04:22:06 INFO - 'tscrollx', 04:22:06 INFO - 'cart']}, 04:22:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:22:06 INFO - 'tsvgr_opacity', 04:22:06 INFO - 'tart', 04:22:06 INFO - 'tscrollx', 04:22:06 INFO - 'cart']}, 04:22:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:06 INFO - 'talos_options': ['--disable-e10s'], 04:22:06 INFO - 'tests': ['tp5o']}, 04:22:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:06 INFO - 'tests': ['tp5o']}, 04:22:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:06 INFO - 'talos_options': ['--disable-e10s', 04:22:06 INFO - '--xperf_path', 04:22:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:06 INFO - 'tests': ['tp5n']}, 04:22:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:06 INFO - 'talos_options': ['--xperf_path', 04:22:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:06 INFO - 'tests': ['tp5n']}}, 04:22:06 INFO - 'talos.zip': {'path': '', 04:22:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:06 INFO - Running post-action listener: _resource_record_post_action 04:22:06 INFO - ##### 04:22:06 INFO - ##### Running create-virtualenv step. 04:22:06 INFO - ##### 04:22:06 INFO - Running pre-action listener: _resource_record_pre_action 04:22:06 INFO - Running main action method: create_virtualenv 04:22:06 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:06 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 04:22:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:06 INFO - Using real prefix '/usr' 04:22:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:07 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:09 INFO - Installing pip.................done. 04:22:09 INFO - Return code: 0 04:22:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:09 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 0x7fc4617fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebb410>, '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 0xebc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebc7a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', '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 04:22:09 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 04:22:09 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 04:22:09 INFO - Using env: {'DISPLAY': ':0', 04:22:09 INFO - 'HOME': '/home/cltbld', 04:22:09 INFO - 'LANG': 'en_US.UTF-8', 04:22:09 INFO - 'LANGUAGE': 'en_US:en', 04:22:09 INFO - 'LOGNAME': 'cltbld', 04:22:09 INFO - 'MAIL': '/var/mail/cltbld', 04:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:09 INFO - 'MOZ_NO_REMOTE': '1', 04:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:09 INFO - 'NO_EM_RESTART': '1', 04:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:09 INFO - 'PWD': '/builds/slave/test', 04:22:09 INFO - 'SHELL': '/bin/bash', 04:22:09 INFO - 'SHLVL': '1', 04:22:09 INFO - 'TERM': 'linux', 04:22:09 INFO - 'TMOUT': '86400', 04:22:09 INFO - 'USER': 'cltbld', 04:22:09 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', 04:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:09 INFO - '_': '/tools/buildbot/bin/python'} 04:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:09 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 04:22:09 INFO - Cleaning up... 04:22:09 INFO - Return code: 0 04:22:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:09 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 0x7fc4617fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebb410>, '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 0xebc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebc7a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', '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 04:22:09 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 04:22:09 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 04:22:09 INFO - Using env: {'DISPLAY': ':0', 04:22:09 INFO - 'HOME': '/home/cltbld', 04:22:09 INFO - 'LANG': 'en_US.UTF-8', 04:22:09 INFO - 'LANGUAGE': 'en_US:en', 04:22:09 INFO - 'LOGNAME': 'cltbld', 04:22:09 INFO - 'MAIL': '/var/mail/cltbld', 04:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:09 INFO - 'MOZ_NO_REMOTE': '1', 04:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:09 INFO - 'NO_EM_RESTART': '1', 04:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:09 INFO - 'PWD': '/builds/slave/test', 04:22:09 INFO - 'SHELL': '/bin/bash', 04:22:09 INFO - 'SHLVL': '1', 04:22:09 INFO - 'TERM': 'linux', 04:22:09 INFO - 'TMOUT': '86400', 04:22:09 INFO - 'USER': 'cltbld', 04:22:09 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', 04:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:09 INFO - '_': '/tools/buildbot/bin/python'} 04:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:09 INFO - Downloading/unpacking psutil>=0.7.1 04:22:09 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 04:22:09 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 04:22:09 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 04:22:09 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 04:22:09 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 04:22:09 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 04:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:11 INFO - Installing collected packages: psutil 04:22:11 INFO - Running setup.py install for psutil 04:22:11 INFO - building 'psutil._psutil_linux' extension 04:22:11 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 04:22:12 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 04:22:12 INFO - building 'psutil._psutil_posix' extension 04:22:12 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 04:22:12 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 04:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:12 INFO - Successfully installed psutil 04:22:12 INFO - Cleaning up... 04:22:12 INFO - Return code: 0 04:22:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:12 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 0x7fc4617fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebb410>, '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 0xebc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebc7a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', '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 04:22:12 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 04:22:12 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 04:22:12 INFO - Using env: {'DISPLAY': ':0', 04:22:12 INFO - 'HOME': '/home/cltbld', 04:22:12 INFO - 'LANG': 'en_US.UTF-8', 04:22:12 INFO - 'LANGUAGE': 'en_US:en', 04:22:12 INFO - 'LOGNAME': 'cltbld', 04:22:12 INFO - 'MAIL': '/var/mail/cltbld', 04:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:12 INFO - 'MOZ_NO_REMOTE': '1', 04:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:12 INFO - 'NO_EM_RESTART': '1', 04:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:12 INFO - 'PWD': '/builds/slave/test', 04:22:12 INFO - 'SHELL': '/bin/bash', 04:22:12 INFO - 'SHLVL': '1', 04:22:12 INFO - 'TERM': 'linux', 04:22:12 INFO - 'TMOUT': '86400', 04:22:12 INFO - 'USER': 'cltbld', 04:22:12 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', 04:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:12 INFO - '_': '/tools/buildbot/bin/python'} 04:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:22:12 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 04:22:12 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 04:22:12 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 04:22:12 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 04:22:12 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 04:22:12 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 04:22:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:22:14 INFO - Installing collected packages: mozsystemmonitor 04:22:14 INFO - Running setup.py install for mozsystemmonitor 04:22:14 INFO - Successfully installed mozsystemmonitor 04:22:14 INFO - Cleaning up... 04:22:14 INFO - Return code: 0 04:22:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:14 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 0x7fc4617fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebb410>, '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 0xebc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebc7a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', '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 04:22:14 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 04:22:14 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 04:22:14 INFO - Using env: {'DISPLAY': ':0', 04:22:14 INFO - 'HOME': '/home/cltbld', 04:22:14 INFO - 'LANG': 'en_US.UTF-8', 04:22:14 INFO - 'LANGUAGE': 'en_US:en', 04:22:14 INFO - 'LOGNAME': 'cltbld', 04:22:14 INFO - 'MAIL': '/var/mail/cltbld', 04:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:14 INFO - 'MOZ_NO_REMOTE': '1', 04:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:14 INFO - 'NO_EM_RESTART': '1', 04:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:14 INFO - 'PWD': '/builds/slave/test', 04:22:14 INFO - 'SHELL': '/bin/bash', 04:22:14 INFO - 'SHLVL': '1', 04:22:14 INFO - 'TERM': 'linux', 04:22:14 INFO - 'TMOUT': '86400', 04:22:14 INFO - 'USER': 'cltbld', 04:22:14 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', 04:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:14 INFO - '_': '/tools/buildbot/bin/python'} 04:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:14 INFO - Downloading/unpacking blobuploader==1.2.4 04:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:22:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:22:16 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 04:22:16 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 04:22:16 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 04:22:16 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 04:22:16 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 04:22:16 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 04:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:22:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:17 INFO - Downloading docopt-0.6.1.tar.gz 04:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:22:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:22:17 INFO - Running setup.py install for blobuploader 04:22:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:22:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:22:17 INFO - Running setup.py install for requests 04:22:18 INFO - Running setup.py install for docopt 04:22:18 INFO - Successfully installed blobuploader requests docopt 04:22:18 INFO - Cleaning up... 04:22:18 INFO - Return code: 0 04:22:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:18 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 0x7fc4617fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebb410>, '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 0xebc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebc7a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', '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 04:22:18 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 04:22:18 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 04:22:18 INFO - Using env: {'DISPLAY': ':0', 04:22:18 INFO - 'HOME': '/home/cltbld', 04:22:18 INFO - 'LANG': 'en_US.UTF-8', 04:22:18 INFO - 'LANGUAGE': 'en_US:en', 04:22:18 INFO - 'LOGNAME': 'cltbld', 04:22:18 INFO - 'MAIL': '/var/mail/cltbld', 04:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:18 INFO - 'MOZ_NO_REMOTE': '1', 04:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:18 INFO - 'NO_EM_RESTART': '1', 04:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:18 INFO - 'PWD': '/builds/slave/test', 04:22:18 INFO - 'SHELL': '/bin/bash', 04:22:18 INFO - 'SHLVL': '1', 04:22:18 INFO - 'TERM': 'linux', 04:22:18 INFO - 'TMOUT': '86400', 04:22:18 INFO - 'USER': 'cltbld', 04:22:18 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', 04:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:18 INFO - '_': '/tools/buildbot/bin/python'} 04:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:18 INFO - Running setup.py (path:/tmp/pip-rgQJe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:18 INFO - Running setup.py (path:/tmp/pip-iSWpTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:18 INFO - Running setup.py (path:/tmp/pip-Pw3PgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:18 INFO - Running setup.py (path:/tmp/pip-QfFtr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:18 INFO - Running setup.py (path:/tmp/pip-SGE7Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:18 INFO - Running setup.py (path:/tmp/pip-qRriL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:18 INFO - Running setup.py (path:/tmp/pip-i5vHIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:18 INFO - Running setup.py (path:/tmp/pip-24gq5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:18 INFO - Running setup.py (path:/tmp/pip-BjH1lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:19 INFO - Running setup.py (path:/tmp/pip-83eCer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:19 INFO - Running setup.py (path:/tmp/pip-tPa7E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:19 INFO - Running setup.py (path:/tmp/pip-Ndr9SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:19 INFO - Running setup.py (path:/tmp/pip-8J4m7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:19 INFO - Running setup.py (path:/tmp/pip-HBWd8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:19 INFO - Running setup.py (path:/tmp/pip-yZeMF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:19 INFO - Running setup.py (path:/tmp/pip-ZcDLWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:19 INFO - Running setup.py (path:/tmp/pip-rejstd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:22:19 INFO - Running setup.py install for manifestparser 04:22:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:22:19 INFO - Running setup.py install for mozcrash 04:22:19 INFO - Running setup.py install for mozdebug 04:22:19 INFO - Running setup.py install for mozdevice 04:22:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Running setup.py install for mozfile 04:22:20 INFO - Running setup.py install for mozhttpd 04:22:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Running setup.py install for mozinfo 04:22:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Running setup.py install for mozInstall 04:22:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Running setup.py install for mozleak 04:22:20 INFO - Running setup.py install for mozlog 04:22:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Running setup.py install for moznetwork 04:22:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Running setup.py install for mozprocess 04:22:20 INFO - Running setup.py install for mozprofile 04:22:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:22:20 INFO - Running setup.py install for mozrunner 04:22:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:22:21 INFO - Running setup.py install for mozscreenshot 04:22:21 INFO - Running setup.py install for moztest 04:22:21 INFO - Running setup.py install for mozversion 04:22:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:22:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:22:21 INFO - Cleaning up... 04:22:21 INFO - Return code: 0 04:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:21 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')]} 04:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:21 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')]} 04:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:21 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 0x7fc4617fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebb410>, '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 0xebc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebc7a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', '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 04:22:21 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 04:22:21 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 04:22:21 INFO - Using env: {'DISPLAY': ':0', 04:22:21 INFO - 'HOME': '/home/cltbld', 04:22:21 INFO - 'LANG': 'en_US.UTF-8', 04:22:21 INFO - 'LANGUAGE': 'en_US:en', 04:22:21 INFO - 'LOGNAME': 'cltbld', 04:22:21 INFO - 'MAIL': '/var/mail/cltbld', 04:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:21 INFO - 'MOZ_NO_REMOTE': '1', 04:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:21 INFO - 'NO_EM_RESTART': '1', 04:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:21 INFO - 'PWD': '/builds/slave/test', 04:22:21 INFO - 'SHELL': '/bin/bash', 04:22:21 INFO - 'SHLVL': '1', 04:22:21 INFO - 'TERM': 'linux', 04:22:21 INFO - 'TMOUT': '86400', 04:22:21 INFO - 'USER': 'cltbld', 04:22:21 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', 04:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:21 INFO - '_': '/tools/buildbot/bin/python'} 04:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:21 INFO - Running setup.py (path:/tmp/pip-u88aZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:21 INFO - Running setup.py (path:/tmp/pip-noOMb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:21 INFO - Running setup.py (path:/tmp/pip-PR_FuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:21 INFO - Running setup.py (path:/tmp/pip-xPQhZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:21 INFO - Running setup.py (path:/tmp/pip-Sl6BFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:21 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)) 04:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:21 INFO - Running setup.py (path:/tmp/pip-BQcoaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:22 INFO - Running setup.py (path:/tmp/pip-vbhrlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:22 INFO - Running setup.py (path:/tmp/pip-s8Dns4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:22 INFO - Running setup.py (path:/tmp/pip-DH75sA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:22 INFO - Running setup.py (path:/tmp/pip-ilWuYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:22 INFO - Running setup.py (path:/tmp/pip-VcHQ_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:22 INFO - Running setup.py (path:/tmp/pip-3O965z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:22 INFO - Running setup.py (path:/tmp/pip-NVzkBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:22 INFO - Running setup.py (path:/tmp/pip-nxksfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:22 INFO - Running setup.py (path:/tmp/pip-QzPaYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:22 INFO - Running setup.py (path:/tmp/pip-aZ5TaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:22 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)) 04:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:22 INFO - Running setup.py (path:/tmp/pip-xqnAnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:22 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)) 04:22:22 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)) 04:22:22 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)) 04:22:22 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)) 04:22:22 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)) 04:22:22 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)) 04:22:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:22 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 04:22:22 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 04:22:22 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 04:22:22 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 04:22:22 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 04:22:22 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 04:22:24 INFO - Downloading blessings-1.6.tar.gz 04:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:22:24 INFO - Installing collected packages: blessings 04:22:24 INFO - Running setup.py install for blessings 04:22:24 INFO - Successfully installed blessings 04:22:24 INFO - Cleaning up... 04:22:24 INFO - Return code: 0 04:22:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:22:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:25 INFO - Reading from file tmpfile_stdout 04:22:25 INFO - Current package versions: 04:22:25 INFO - argparse == 1.2.1 04:22:25 INFO - blessings == 1.6 04:22:25 INFO - blobuploader == 1.2.4 04:22:25 INFO - docopt == 0.6.1 04:22:25 INFO - manifestparser == 1.1 04:22:25 INFO - mozInstall == 1.12 04:22:25 INFO - mozcrash == 0.17 04:22:25 INFO - mozdebug == 0.1 04:22:25 INFO - mozdevice == 0.48 04:22:25 INFO - mozfile == 1.2 04:22:25 INFO - mozhttpd == 0.7 04:22:25 INFO - mozinfo == 0.9 04:22:25 INFO - mozleak == 0.1 04:22:25 INFO - mozlog == 3.1 04:22:25 INFO - moznetwork == 0.27 04:22:25 INFO - mozprocess == 0.22 04:22:25 INFO - mozprofile == 0.28 04:22:25 INFO - mozrunner == 6.11 04:22:25 INFO - mozscreenshot == 0.1 04:22:25 INFO - mozsystemmonitor == 0.0 04:22:25 INFO - moztest == 0.7 04:22:25 INFO - mozversion == 1.4 04:22:25 INFO - psutil == 3.1.1 04:22:25 INFO - requests == 1.2.3 04:22:25 INFO - wsgiref == 0.1.2 04:22:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:25 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')]} 04:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:25 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')]} 04:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:25 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 0x7fc4617fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebb410>, '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 0xebc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebc7a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', '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 04:22:25 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 04:22:25 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 04:22:25 INFO - Using env: {'DISPLAY': ':0', 04:22:25 INFO - 'HOME': '/home/cltbld', 04:22:25 INFO - 'LANG': 'en_US.UTF-8', 04:22:25 INFO - 'LANGUAGE': 'en_US:en', 04:22:25 INFO - 'LOGNAME': 'cltbld', 04:22:25 INFO - 'MAIL': '/var/mail/cltbld', 04:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:25 INFO - 'MOZ_NO_REMOTE': '1', 04:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:25 INFO - 'NO_EM_RESTART': '1', 04:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:25 INFO - 'PWD': '/builds/slave/test', 04:22:25 INFO - 'SHELL': '/bin/bash', 04:22:25 INFO - 'SHLVL': '1', 04:22:25 INFO - 'TERM': 'linux', 04:22:25 INFO - 'TMOUT': '86400', 04:22:25 INFO - 'USER': 'cltbld', 04:22:25 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', 04:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:25 INFO - '_': '/tools/buildbot/bin/python'} 04:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:25 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)) 04:22:25 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)) 04:22:25 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)) 04:22:25 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)) 04:22:25 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)) 04:22:25 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)) 04:22:25 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)) 04:22:25 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)) 04:22:25 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)) 04:22:25 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)) 04:22:25 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)) 04:22:25 INFO - Cleaning up... 04:22:25 INFO - Return code: 0 04:22:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:22:25 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')]} 04:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:25 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')]} 04:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:25 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 0x7fc4617fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebb410>, '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 0xebc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebc7a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', '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 04:22:25 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 04:22:25 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 04:22:25 INFO - Using env: {'DISPLAY': ':0', 04:22:25 INFO - 'HOME': '/home/cltbld', 04:22:25 INFO - 'LANG': 'en_US.UTF-8', 04:22:25 INFO - 'LANGUAGE': 'en_US:en', 04:22:25 INFO - 'LOGNAME': 'cltbld', 04:22:25 INFO - 'MAIL': '/var/mail/cltbld', 04:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:25 INFO - 'MOZ_NO_REMOTE': '1', 04:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:25 INFO - 'NO_EM_RESTART': '1', 04:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:25 INFO - 'PWD': '/builds/slave/test', 04:22:25 INFO - 'SHELL': '/bin/bash', 04:22:25 INFO - 'SHLVL': '1', 04:22:25 INFO - 'TERM': 'linux', 04:22:25 INFO - 'TMOUT': '86400', 04:22:25 INFO - 'USER': 'cltbld', 04:22:25 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', 04:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:25 INFO - '_': '/tools/buildbot/bin/python'} 04:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:25 INFO - Downloading/unpacking jsonschema 04:22:25 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 04:22:25 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 04:22:25 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 04:22:25 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 04:22:25 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 04:22:25 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 04:22:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:22:27 INFO - Downloading/unpacking functools32 (from jsonschema) 04:22:27 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 04:22:27 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 04:22:27 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 04:22:27 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 04:22:27 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 04:22:27 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 04:22:27 INFO - Downloading functools32-3.2.3-2.tar.gz 04:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:22:27 INFO - warning: no files found matching '*.txt' 04:22:27 INFO - no previously-included directories found matching 'build' 04:22:27 INFO - no previously-included directories found matching 'dist' 04:22:27 INFO - no previously-included directories found matching '.git*' 04:22:27 INFO - Installing collected packages: jsonschema, functools32 04:22:27 INFO - Running setup.py install for functools32 04:22:27 INFO - warning: no files found matching '*.txt' 04:22:27 INFO - no previously-included directories found matching 'build' 04:22:27 INFO - no previously-included directories found matching 'dist' 04:22:27 INFO - no previously-included directories found matching '.git*' 04:22:27 INFO - Successfully installed jsonschema functools32 04:22:27 INFO - Cleaning up... 04:22:27 INFO - Return code: 0 04:22:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:22:27 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')]} 04:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:27 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')]} 04:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:27 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 0x7fc4617fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebb410>, '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 0xebc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebc7a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', '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 04:22:27 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 04:22:27 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 04:22:27 INFO - Using env: {'DISPLAY': ':0', 04:22:27 INFO - 'HOME': '/home/cltbld', 04:22:27 INFO - 'LANG': 'en_US.UTF-8', 04:22:27 INFO - 'LANGUAGE': 'en_US:en', 04:22:27 INFO - 'LOGNAME': 'cltbld', 04:22:27 INFO - 'MAIL': '/var/mail/cltbld', 04:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:27 INFO - 'MOZ_NO_REMOTE': '1', 04:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:27 INFO - 'NO_EM_RESTART': '1', 04:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:27 INFO - 'PWD': '/builds/slave/test', 04:22:27 INFO - 'SHELL': '/bin/bash', 04:22:27 INFO - 'SHLVL': '1', 04:22:27 INFO - 'TERM': 'linux', 04:22:27 INFO - 'TMOUT': '86400', 04:22:27 INFO - 'USER': 'cltbld', 04:22:27 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', 04:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:27 INFO - '_': '/tools/buildbot/bin/python'} 04:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:28 INFO - Downloading/unpacking flake8 04:22:28 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 04:22:28 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 04:22:28 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 04:22:28 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 04:22:28 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 04:22:28 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 04:22:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:22:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:22:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 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 04:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:22:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:22:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:22:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:22:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:22:30 INFO - no previously-included directories found matching 'docs/_build' 04:22:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:22:30 INFO - Running setup.py install for pep8 04:22:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:22:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:22:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:22:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:22:30 INFO - no previously-included directories found matching 'docs/_build' 04:22:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:22:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:22:30 INFO - Cleaning up... 04:22:31 INFO - Return code: 0 04:22:31 INFO - Running post-action listener: _resource_record_post_action 04:22:31 INFO - Running post-action listener: _start_resource_monitoring 04:22:31 INFO - Starting resource monitoring. 04:22:31 INFO - ##### 04:22:31 INFO - ##### Running install step. 04:22:31 INFO - ##### 04:22:31 INFO - Running pre-action listener: _resource_record_pre_action 04:22:31 INFO - Running main action method: install 04:22:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:31 INFO - Reading from file tmpfile_stdout 04:22:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:22:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:22:31 INFO - Reading from file tmpfile_stdout 04:22:31 INFO - Output received: 04:22:31 INFO - Usage: mozinstall [options] installer 04:22:31 INFO - Options: 04:22:31 INFO - -h, --help show this help message and exit 04:22:31 INFO - -d DEST, --destination=DEST 04:22:31 INFO - Directory to install application into. [default: 04:22:31 INFO - "/builds/slave/test"] 04:22:31 INFO - --app=APP Application being installed. [default: firefox] 04:22:31 INFO - mkdir: /builds/slave/test/build/application 04:22:31 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'] 04:22:31 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 04:22:46 INFO - Reading from file tmpfile_stdout 04:22:46 INFO - Output received: 04:22:46 INFO - /builds/slave/test/build/application/firefox/firefox 04:22:46 INFO - Running post-action listener: _resource_record_post_action 04:22:46 INFO - ##### 04:22:46 INFO - ##### Running run-tests step. 04:22:46 INFO - ##### 04:22:46 INFO - Running pre-action listener: _resource_record_pre_action 04:22:46 INFO - Running main action method: run_tests 04:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:22:46 INFO - Python 2.7.3 04:22:46 INFO - Return code: 0 04:22:46 INFO - grabbing minidump binary from tooltool 04:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:46 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 0xebb410>, '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 0xebc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:22:46 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 04:22:46 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 04:22:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:22:47 INFO - Return code: 0 04:22:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:22:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:22:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:22:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:22:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:22:48 INFO - Return code: 0 04:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 04:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 04:22:48 INFO - Using env: {'DISPLAY': ':0', 04:22:48 INFO - 'HOME': '/home/cltbld', 04:22:48 INFO - 'LANG': 'en_US.UTF-8', 04:22:48 INFO - 'LANGUAGE': 'en_US:en', 04:22:48 INFO - 'LOGNAME': 'cltbld', 04:22:48 INFO - 'MAIL': '/var/mail/cltbld', 04:22:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:22:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:48 INFO - 'MOZ_NO_REMOTE': '1', 04:22:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:48 INFO - 'NO_EM_RESTART': '1', 04:22:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:48 INFO - 'PWD': '/builds/slave/test', 04:22:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:22:48 INFO - 'SHELL': '/bin/bash', 04:22:48 INFO - 'SHLVL': '1', 04:22:48 INFO - 'TERM': 'linux', 04:22:48 INFO - 'TMOUT': '86400', 04:22:48 INFO - 'USER': 'cltbld', 04:22:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611', 04:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:48 INFO - '_': '/tools/buildbot/bin/python'} 04:22:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 04:22:48 INFO - mozversion application_buildid: 20160406025815 04:22:48 INFO - mozversion application_changeset: 05ce1f2670ae52e928af76df72e78989935141e3 04:22:48 INFO - mozversion application_display_name: Nightly 04:22:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:22:48 INFO - mozversion application_name: Firefox 04:22:48 INFO - mozversion application_remotingname: firefox 04:22:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:22:48 INFO - mozversion application_vendor: Mozilla 04:22:48 INFO - mozversion application_version: 48.0a1 04:22:48 INFO - mozversion platform_buildid: 20160406025815 04:22:48 INFO - mozversion platform_changeset: 05ce1f2670ae52e928af76df72e78989935141e3 04:22:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:22:48 INFO - mozversion platform_version: 48.0a1 04:22:48 INFO - using testdate: 1459941768 04:22:48 INFO - actual date: 1459941768 04:22:48 INFO - starting webserver on 'localhost:42099' 04:22:48 INFO - SUITE-START | Running 2 tests 04:22:48 INFO - TEST-START | dromaeo_css 04:22:48 INFO - operating with platform_type : linux_ 04:22:48 INFO - Initialising browser for dromaeo_css test... 04:22:48 INFO - TEST-INFO | started process 9104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx63UYQ/profile http://localhost:42099/getInfo.html) 04:22:52 INFO - PROCESS | 9104 | __metrics Screen width/height:1600/1200 04:22:52 INFO - PROCESS | 9104 | colorDepth:24 04:22:52 INFO - PROCESS | 9104 | Browser inner width/height: 1024/697 04:22:52 INFO - PROCESS | 9104 | __metrics 04:22:53 ERROR - PROCESS | 9104 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:22:54 INFO - TEST-INFO | 9104: exit 0 04:22:54 INFO - Browser initialized. 04:22:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:22:54 INFO - TEST-INFO | started process 9185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx63UYQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:06 INFO - PROCESS | 9185 | RSS: Main: 154083328 04:23:06 INFO - PROCESS | 9185 | 04:23:57 INFO - PROCESS | 9185 | 1459941837824 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] 04:26:09 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:42099/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42099/tests/dromaeo/cssquery-ext.html) 04:26:10 INFO - PROCESS | 9185 | RSS: Main: 245350400 04:26:10 INFO - PROCESS | 9185 | 04:29:12 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:42099/tests/dromaeo/cssquery-ext.html (next: http://localhost:42099/tests/dromaeo/cssquery-jquery.html) 04:29:13 INFO - PROCESS | 9185 | RSS: Main: 241930240 04:29:13 INFO - PROCESS | 9185 | 04:32:14 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:42099/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42099/tests/dromaeo/cssquery-mootools.html) 04:32:15 INFO - PROCESS | 9185 | RSS: Main: 234614784 04:32:15 INFO - PROCESS | 9185 | 04:35:17 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:42099/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42099/tests/dromaeo/cssquery-prototype.html) 04:35:17 INFO - PROCESS | 9185 | RSS: Main: 203292672 04:35:17 INFO - PROCESS | 9185 | 04:38:20 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:42099/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42099/tests/dromaeo/cssquery-yui.html) 04:38:21 INFO - PROCESS | 9185 | RSS: Main: 200220672 04:38:21 INFO - PROCESS | 9185 | 04:41:23 INFO - PROCESS | 9185 | Cycle 1(1): loaded http://localhost:42099/tests/dromaeo/cssquery-yui.html (next: http://localhost:42099/tests/dromaeo/cssquery-dojo.html) 04:41:23 INFO - PROCESS | 9185 | RSS: Main: 310435840 04:41:23 INFO - PROCESS | 9185 | 04:41:23 INFO - PROCESS | 9185 | __start_tp_report 04:41:23 INFO - PROCESS | 9185 | _x_x_mozilla_page_load 04:41:23 INFO - PROCESS | 9185 | _x_x_mozilla_page_load_details 04:41:23 INFO - PROCESS | 9185 | |i|pagename|runs| 04:41:23 INFO - PROCESS | 9185 | |0;dojo.html;2649.549576571983;2743.7530622243994;2747.2445077603643;2758.3379988802694;2777.8055536112474;4573.862784116473;4652.116097941389;4707.129181101494;4709.7645117744105;4723.811047558098;4659.068186362724;4690.413698287714;4691.0617876424685;4704.059188162364;4754.120487709776;4269.786510674469;4315.784210789464;4360.106178233455;4377.518472967971;4462.1075784843;4404.933925991113;4421.9336709949375;4423.159599676052;4473.418455600784;4476.776161191944;4247.086876321606;4251.128518653669;4339;4340.7178533395545;4363.912721745579;4318.114786468766;4330.480342358937;4343.370211319341;4389.824407023715;4395.450568678915;4305.870823875289;4319.76241306728;4323.437953066113;4363.825446982117;4368.170047690928;4510.052888893337;4593.908121837545;4603.079384123189;4632.467266264355;4636.985959126595;4923.852284431473;4947.975260123712;4948.67833590819;4951.876203094916;4956.553910148068;4969.329140566014;5049.293098966147;5152.278680984665;5177.896442071137;5201.479852014806;4713.764311784432;4732.361131247307;4733.2900064989835;4738.810447582093;4782.95217047832;4914.90170196594;5149.047426226085;5149.6910185389;5158.509941555546;5159.045576568347;4962.727050012284;4997.775100120431;5001.8499445016705;5043.621728370387;5050.924236136461;5079.5428411443145;5112.923306150411;5122.334096567422;5123.820666276662;5170.6380553360905;4867.829625963074;4940.975295123573;4989.101961646866;5068.391792984866;5070.645054846199;5021.271915572294;5045.899082018339;5068.265101560253;5082.161443361878;5088.898222035538;4286.914261714748;4295.420118284054;4295.570442955679;4301.612854843079;4337.8264869404875;3630.8003059831435;3782.9711357404276;3787.4129509926006;3799.069228039148;3832.176082142297;4344.869653910325;4346.913061738811;4394.758288294174;4421.42521472213;4430.800613972379;5078.568321692624;5107.489251074863;5107.846764596994;5128.692278463304;5171.50870667286;4304.720193187495;4392.912141757147;4409.162259170747;4409.294512877924;4459.2865141577195;4474.664400169935;4495.865124046284;4507.864764057083;4540.591346778806;4554.63562914966;4819.156647586588;4824.0110777291275;4828.299896514985;4833.05755377698;4838.322634831196;4885.120678277802;4954.9752251238515;5094.3886733590725;5097.133487307093;5127.820526281712;4861;4861.854144375674;4867.148249056472;4887.437944636412;4931.950680493149;5028.362561418892;5037.722925239001;5039.6220283479615;5045.243213517855;5093.821716239914;4934.18585933317;4990.251462280542;5062.746862656926;5115.590752739698;5185.248139019896;4922.65541412112;4931.580815630568;4940.061388336205;4952.678075925053;4986.825461108844;4929.014197160511;4933.876653083558;4934.9753251233515;4938.037082768826;4977.427595826526;4800.951990480051;4818.060478206716;4866.659333846596;4899;4908.582770464551;4927.8275260367145;4930.211166213388;4938.876528086683;4953.380827396575;5016.849494515171;4828.082664293773;4840.757962101951;4849.393825771778;4850.46644869057;4903.5586797188425 04:41:23 INFO - PROCESS | 9185 | |1;ext.html;510.82121257559857;517.2913109040614;538.6418032008714;539.2800611184069;549.8845242499074;27412;34550.65449345509;34911.127221819464;34928.82535587325;35016.94949151526;41665;42384.15231695372;42407.15185696284;42490.36264456036;42511.149777004444;7632.9236707633045;7877.960610196941;7879.054513458364;7879.1726868678825;7884.881726774103;7819.178986206452;7953.72161974331;7957.880631790527;7958.442908996372;7962.920370796276;7904.972353594025;7985.640646170937;7987.5606841623685;7987.7204297849585;7987.7204297849585;7704.730334438295;7750.186230445778;7757.301842834144;7762.340201082915;7949.920500794976;7726.304632583095;7833.49082309648;7841.294283514511;7844;7851.45039847211;37655.4351684725;38098;38219.04452388685;38303.42544861829;38368;3007.6992300769966;3079.107058952901;3265.216348076445;3332.6667333266723;3384.983075084609;28736.712632873823;29247;29520.557191642143;29932.401351973058;30104.09687709372;3206.9679303206904;3348.68187522185;3364.798112113281;3399.3201359728155;3468.7051600613977;184431;185500;186262;186737;187354;50101.74949125231;53604;54305.72847135739;54400.72799635977;59003.70498147482;52903;53249;53259;53360;53475.46524534783;14471.49349772753;14831;14832.25838708082;14838.18389988561;14840.628984275263;9647.9035209647;11140.777184456265;11163.776724465466;11320.37737924422;11637.534498620129;19538.413847584594;20613.58772824535;20729;20729.98830339185;20742;7539.547627142389;7549.433792465477;7575.6969721210535;7671.2712292332135;7762.146367643415;879.9648014079493;888.3426264564176;906.7461110888962;968.1480297338297;1008.8700655266149;25968.8701556491;26938;27282.72717272802;27343.316417089733;27627.86186069057;1001.329109496639;1003.4531180506641;1018.6027449294781;1044.3681572648438;1061.8354155105972;13813.723725525635;14117.858821411859;14293.356798944073;14310.713785724227;14311.713765724835;266153;268940;270707;272080;272443;46814;47362.289565656545;47442;47451.28823067657;47462;1207.5169932027259;1231.6797632615585;1233.858106317767;1243.3720970909815;1250.481050364107;26148.34629134287;27626.171214863585;27715.44569108566;27972;28063.859680702284;41124.1775164501;41839.58160418357;42125.368119478844;42186;42213.57786422219;249858;252891;253009;253972;254739;32592.837035814668;32625.510617340286;32995.8350208257;33045.66954330522;33453.33093338168;41432.58567414408;41579.37630935599;41836.37245441382;43737;45119.77440112778;36810.26379472342;37730;37964;37976.81011595035;38068;36535.26929461449;37509.24981500409;38062.42906356351;38192.80903595464;38257.80871095627;36107;37020.44469333016;37073.44389834101;37120.28797120266;37151.25697485981;32250.35499290048;33416.83291583624;33460.1634959128;33463;34134;25826.741732582435;26151.607725884507;26183;26219.475610488065;26663.600045999712 04:41:23 INFO - PROCESS | 9185 | |2;jquery.html;336.56583007919784;337.70450855501434;344.338869370808;349.0331780966721;351.1169408936525;14535.055221410614;15370.615734606627;15988.12065336406;16010;16042.35830566776;14580.562583122497;14660.340284687189;14776.261186940663;15469.690606187869;15621;4856.368672072635;4986.5761410280165;5001.7499125043605;5003.374578177728;5023.8492845214705;4859.562639362457;4863.683860549053;4991.500849915015;4994.500549945013;5050.545450909417;4929.21132618781;4952.331435256248;4952.826651067214;4960.70235785854;4964.15609346412;4758.595519380857;4939.753012349386;4940.7776650050655;4961.900761984776;4971.105201063807;4407.360932664746;4409.294512877924;4418.734875907456;4419.955800441987;4432.268675668511;19095.713564296548;19494;19994.900025499926;20004.69992950107;20032.1987120515;1992.4520756791853;1996.291316582607;2001.2195243854908;2138.9358319250446;2506.7994560435304;8482.36382271326;8533.487990720576;8642.178992995656;8988.685396011108;12832.935835320764;1582.4461438496548;1633.8447847454472;1643.4165871115702;1644.161477646409;1699.7620333153245;57230.427695723345;61207.693961529905;62042.68978655123;62107.378926210615;62773;8971.730848074569;9306.953465232766;9343.2525397968;9371.765705857408;9571.952140239255;12692.746145077046;12699.174553653984;12787.296698681475;12803.743925121631;12813.103082784115;6995.125609298838;7230.674619642129;7233.819154521074;7334.779956601311;7342.5227360221415;7006.859862802818;7028.051213086168;7064.116985376828;7156.92843071573;7178.892316615255;4175;4188.790560472025;4196.9370459443135;4221.092465120014;4286.314189729628;1663.8252983436564;1696.6182608912895;1721.1308289314068;1746.05712915027;1761.4011236179504;827.1825525201153;859.5186695450568;908.8954770201511;914.0996118822954;924.4684306523776;15807.525774226791;15968.658334874228;16399.754003689955;16474.588135296475;16628.58428539296;834.1200033964226;849.4436144325476;861.7371701631063;871.581361721216;876.1982785750967;9212.769680758034;9253.120953509406;9319.394239374418;9344.579493922789;9396.718098457057;289595;300329;388491;390057;397630;58228.70885645544;65783.34216657773;68757;70335;75112.62443687856;965.8454647256546;967.7725734452398;984.2027957354566;1011.2870426349406;1019.50553981319;14757.483488077865;14896.180710061051;15127.470538531099;15342.923285383948;15618.687626247183;31540.36919261648;33325.33349333048;33485;34348.82825585856;35111.82444087763;36174.4573831398;38661.420078699404;38768.80615596904;38852.2229555413;39046;7354.411647068328;7404.518706284074;7441.851162976818;7463.2909873564095;7494.887576686245;8412.116727743498;11071.612493562687;11475.540978360772;11577.826332605186;11720.296782193096;9818.410895346302;9855.408675479493;10092.293539452168;10307.123894469054;10335.276530642783;9613.615455381707;9961.800763984824;10363.170946324126;10432.530536125741;10568.418736969541;10417.322874013165;10578.365298082139;10581.788364232827;10609.8939010612;10624.150067994697;7469.813254668677;7542.245775422633;7591.848163036598;7598.240175982358;7618.352440042437;7859.331956783737;10465.529051192867;10502.10732087781;10511.842322365017;10772.515236814206 04:41:23 INFO - PROCESS | 9185 | |3;mootools.html;1407.429990853704;1433.8351089624693;1577.9684406311874;1737.088028784887;1803.6302557975616;7510.887336689947;7684.231576842313;7695.846083078335;7703.884441733371;7711.807204819876;6360.045993101037;7162.1405431348185;7382.18795932447;7404.222556631544;7579.924200757991;2217.246136313653;2255.729312482496;2255.875926824024;2256.0411824974403;2257.7064981552376;1930.2472035906007;2213.7454192767796;2240;2260.8756518391483;2266.6713326567638;2178.6187417202004;2235.6870038194666;2236.39617303328;2238.3173132194675;2243.7644047375034;2202.79947428651;2230.4981379189717;2246.9550608987893;2248.662700594924;2249.8875056247202;2191.583599116179;2197.747259065212;2200.7359116905914;2201.119552179125;2219.966700499494;7552.811179720496;7637.083549973983;7651.196624354418;7807.492512986638;7817.8827317590285;4489.214387482178;4655.185342565038;4658.604018658418;4659.743714095724;4662.53374662531;2786.749192572678;2837.092130518235;2937.8971735989353;2962.22982024673;2966;857.9914200857974;862.4178679391448;871.2072014466868;908.4413085952092;915.8031023330016;10386.065254127165;10405.47972601367;10421.374717516897;10440.895591044069;10457.477126143738;4175.812088455966;4187.811548480326;4298.20483210607;4308.698391112592;4318.41701370311;8870.600822962982;8915;8926.152015558511;8928.687495937611;8929.33030022751;4703.082898834763;4729.976350118296;4732.290156476487;4732.905341893143;4733.881652958704;4257.893552661209;4259.169461954951;4260.147970405931;4262.914741705148;4265.850695225652;3320.0869760815967;3431.227973705896;3442.7934323940644;3490.458978858281;3492.7555071144775;1090.3566895531517;1170.1808733886144;1179.5871444994355;1206.879312068786;1212.4362171590076;995.8854731705802;1015.603914473356;1016.9440680762481;1085.5874767588266;1237.2638280223252;6877.862442751117;6886.655667216619;6893.20728116263;6924.203716572558;6926;1022.5858527296457;1028.4035259549444;1042.4839704346398;1052.1109662335314;1053.2364036073784;5455.072637651609;5595.048841696921;5620.381758006616;5696.287964004499;5703.144528320702;8358.164183581594;8522.062573116953;8614.267787238156;8659.610317535726;8668.739937801876;8429.40994130405;8476.618552165168;8519.872201916976;8573.18554737299;8582.87125693115;6683.7660681875905;6796.898046529207;6925.861482770317;6939.757108501179;7009.369156775812;6912.792616221522;6916.827079323057;6925.445964322741;6928.7228510859;6928.757493487704;7810.531368117704;8007.799805004922;8038.437309388287;8164.224398682116;8189.549574773445;8225.79435514117;8486.660533578588;8501.404901656824;8507.8723819144;8517.403781735218;6529.575577587441;6758.797236082925;6781.89827152603;6792.083068785848;6812.795616131524;7001.229864714979;7004.684789184397;7007.789766307019;7021.508494405342;7036.9296307036275;5154.819581314786;6531.836704082246;6618.073469714148;6735.898961515483;6795.966020169867;6168.506519478341;6170.753169873155;6286.37136286386;6298.275698294755;6339.144215530844;6542.509311801538;6601.24085730128;6603.075569420189;6603.768868089786;6610.041543976193;6265.561410701207;6299.181106456132;6341.682915854097;6346.2067241594805;6352.205974253218;6265.592736472115;6343.016832390987;6350;6365.618062916054;6371.936280637135 04:41:23 INFO - PROCESS | 9185 | |4;prototype.html;298.852068226228;309.9225193701574;310.3591084410692;316.80358177929656;316.8922566327447;5258.973705131479;5373.382061062979;5429.049916264647;5429.429909859467;5463.535599474039;5327.653702509334;5363.410024897258;5375;5394.163904594784;5397.298351214346;3915.804209789513;4000.6999475039343;4048.9190216195657;4145.461090058288;4157.106222162234;4032.475778148851;4034.112495251055;4102.543597023058;4106.568810274923;4139.668826493888;4091.5703851095504;4098.631123198911;4104.302268614328;4107.979460102695;4117.773522456278;3918.804059797027;4102.856400025999;4102.938455923164;4103.8974025649295;4112.732672376316;3483.860645574174;3572.821358932069;3581.6776490116013;3586.8027258500774;3588;5150.742462876879;5160.91620759641;5175;5182.274481572583;5194.766235519411;4748.3114948332295;4751.976240118777;4753.595944344735;4758.61931045519;4762.571368576845;5661.320641523002;5662.207290979266;5668.31980162379;5674.120511320752;5677.432256774289;3936.5866584008554;3946;3947.2697550953167;3951.5060617422823;3952.7628342299554;5670;5876.794312199053;5950.5834591578605;5968.343482216953;5969.671668058255;3985.1830374773103;3989.68082553395;4017.83928642851;4021.8391264349098;4025.5169379674626;4065.207284579538;4071.0229544909603;4073.165001174752;4073.51117865858;4074.898127546776;4690.296455531698;4698.459677137104;4700.435947686231;4708.576228139484;4709.529047095331;5671.2060311556415;5671.943280567141;5676.801311954062;5680.318361796528;5681.005823980787;1407.5847624950663;1434.0033676594667;1437.525616546537;1437.9352929118215;1438.2449214162439;913.1872633356318;944.730751735752;955.47926380123;959.8992105828927;963.1861077389594;4827.975860120747;4907.901841963141;5033.899322013613;5042.294078828967;5090.796368145233;5904.380040095728;5958.880822383528;5962;5970.283565972111;5973.701314934236;5068.265101560253;5069.264956581275;5069.949300507022;5072.644914855925;5075.187969924795;3138.450771115046;3175.4442972479724;3178.8251646159683;3185.7132858042887;3185.9681403185673;5614.1859430382365;5617.466340697627;5621.887562248814;5626.831195064155;5627.803026894039;5876.529877609781;6058.091286307089;6074.119252708332;6096.298925623521;6097.298810636745;5600.691961942132;5612.494875461228;5624.3813180550105;5629.4652008059165;5632.183333416549;5928.555358348228;5935.643861368331;5936.525077993837;5946.167536544974;5947.256592925884;5780.971095144498;5799.971000144972;5800.76796928135;5804.593678442468;5824.301083869963;5623.2408624835125;5623.437656234344;5629.296337957755;5629.4652008059165;5639.238702775237;3892.2410130024373;4023.4568333275806;4035.4350390944705;4039.2729308723538;4056.5537790843573;5884.6469211847425;5885.793997210249;5902.173695682522;5913.083472061838;5915.940840591539;5720.3707592165665;5724.570657200643;5725.599208055396;5731.140328950691;5734.770609175586;5704.80033198836;5709.286339207599;5717.085266357363;5726.026575482095;5727.799527016535;5627.324721033502;5630.0991841305195;5635;5635.718214089361;5643.71781410936;5488.725563721878;5690.345610254708;5693.146028095819;5704.401037891128;5713.257276554022;5547.972260138674;5622.2128901954575;5625.971870140623;5629.746661400329;5636.351819540805 04:41:23 INFO - PROCESS | 9185 | |5;yui.html;683.4464084091885;756.4591317208196;772.4554189296547;777.1529033353647;789.1595450844846;10546.683599492018;10792.78414431711;10804.297720648152;10817.567297308098;10855.077318427933;11248.887511124887;11254.381009044499;11285.492152853121;11296.661100166988;11322.773544529104;640.586821500131;655.3217419970332;792.9801754956114;822.7819627798638;824.6083110522513;808.0666829811547;817.456391499655;817.8691409374501;818.8034871630796;818.8157664525494;855.7732200966749;856.195176534056;856.5545916123612;859.5788063848731;860.7202659135775;682.2086379799433;692.7713854428026;693.2686016252851;845.7082306604211;850.2602735620019;622.7508996401431;623.1245100633618;623.2365352443267;627.1971875998729;630.1964994631835;11714.23857449263;12196.634100976986;12232.694182645417;12234.08244381675;12293.938530307381;12377.566785162477;12498;12991.740165196738;13005.86994130056;13086;9655.17930975868;9807.26445516589;9868.259880508991;9873.506324683736;9981.500924953796;3232.127325622069;3269.64309811428;3282.96717032829;3300.5709257796575;3307.206270495088;43330;43409.13181736379;43499.34750978738;43504;45560.3165952511;9674.129328360481;9825.263105267133;10064.849027264598;10189;10328.586856525655;16491.422800201934;16556.42052528156;16633;16677.833221667872;16697;6267;6524.412802847766;6566.409023187841;6582.539222254492;6824.7952561423235;3567.9108022299133;3639.0224976746395;3755.3240416724707;3786.072412259014;3930.8427662893737;2765.4745598336253;2800.495910736087;2809.803313768017;2810.1429064135227;2816.971830281671;505.0883155903556;523.9371275446971;530.936287645485;562.0725802425948;589.8289496046184;545.6916841984346;581.4824805922732;599.66718471248;601.0653433910311;610.971574373086;7278.871774874903;7483.176850546435;7616.645146495055;7764;8915.42049766763;486.60584926209884;507.2214151277771;518.4996478398364;519.948005199477;526.2369564132024;3577.5170352002665;3627.183883626216;3713.294474049922;3755.605661405568;3797.240551889633;45452;45860.08279834384;46001.53998459972;46331;46465;43981.12037759227;44116.55883441189;44346.334804977305;44694.77652611716;44707;35589;36361.818190908874;36388.45417318743;36436;36915.63084369175;8529.82940341202;8563.400561960603;8620.353473489638;8646.697365592174;8730.825383492422;31365.686343136276;31753.841230794624;31876;32197;32312;36592.0851978692;38826.22347552977;39230.21539569135;39630.20739585134;39824.60175398209;9730.41617502952;9938;10191.54138063774;10327.225458090523;10515.737106572396;10997.945010274898;11005.17461190398;11393.430328483377;11421.543138274375;11872.881271187178;10908.945455272673;11138.944305278746;11379.487923043649;11414.657560273205;11698.2981021139;11419.486123124314;11561.826572601249;11680.532778689098;11700.765984680429;11762.235454695418;10128.392296462236;10147.238957078396;10494.21293403013;10555.208359373231;11408.486618102039;9406.717798466058;9585.233181345615;9686.9031309686;9927.503624818875;10043.146332561522;8459.83080338402;9399.201067909304;9416.764580885532;9434.433933963985;9436.764080898032 04:41:23 INFO - PROCESS | 9185 | __end_tp_report 04:41:23 INFO - PROCESS | 9185 | __start_cc_report 04:41:23 INFO - PROCESS | 9185 | _x_x_mozilla_cycle_collect,937 04:41:23 INFO - PROCESS | 9185 | __end_cc_report 04:41:23 INFO - PROCESS | 9185 | __startTimestamp1459942883898__endTimestamp 04:41:23 INFO - PROCESS | 9185 | 04:41:23 INFO - PROCESS | 9185 | ------- Summary: start ------- 04:41:23 INFO - PROCESS | 9185 | Number of tests: 6 04:41:23 INFO - PROCESS | 9185 | 04:41:23 INFO - PROCESS | 9185 | [#0] dojo.html Cycles:165 Average:4681.10 Median:4838.32 stddev:477.56 (9.9%) stddev-sans-first:451.65 04:41:23 INFO - PROCESS | 9185 | Values: 2649.5 2743.8 2747.2 2758.3 2777.8 4573.9 4652.1 4707.1 4709.8 4723.8 4659.1 4690.4 4691.1 4704.1 4754.1 4269.8 4315.8 4360.1 4377.5 4462.1 4404.9 4421.9 4423.2 4473.4 4476.8 4247.1 4251.1 4339.0 4340.7 4363.9 4318.1 4330.5 4343.4 4389.8 4395.5 4305.9 4319.8 4323.4 4363.8 4368.2 4510.1 4593.9 4603.1 4632.5 4637.0 4923.9 4948.0 4948.7 4951.9 4956.6 4969.3 5049.3 5152.3 5177.9 5201.5 4713.8 4732.4 4733.3 4738.8 4783.0 4914.9 5149.0 5149.7 5158.5 5159.0 4962.7 4997.8 5001.8 5043.6 5050.9 5079.5 5112.9 5122.3 5123.8 5170.6 4867.8 4941.0 4989.1 5068.4 5070.6 5021.3 5045.9 5068.3 5082.2 5088.9 4286.9 4295.4 4295.6 4301.6 4337.8 3630.8 3783.0 3787.4 3799.1 3832.2 4344.9 4346.9 4394.8 4421.4 4430.8 5078.6 5107.5 5107.8 5128.7 5171.5 4304.7 4392.9 4409.2 4409.3 4459.3 4474.7 4495.9 4507.9 4540.6 4554.6 4819.2 4824.0 4828.3 4833.1 4838.3 4885.1 4955.0 5094.4 5097.1 5127.8 4861.0 4861.9 4867.1 4887.4 4932.0 5028.4 5037.7 5039.6 5045.2 5093.8 4934.2 4990.3 5062.7 5115.6 5185.2 4922.7 4931.6 4940.1 4952.7 4986.8 4929.0 4933.9 4935.0 4938.0 4977.4 4801.0 4818.1 4866.7 4899.0 4908.6 4927.8 4930.2 4938.9 4953.4 5016.8 4828.1 4840.8 4849.4 4850.5 4903.6 04:41:23 INFO - PROCESS | 9185 | 04:41:23 INFO - PROCESS | 9185 | [#1] ext.html Cycles:180 Average:40799.11 Median:36321.13 stddev:62170.04 (171.2%) stddev-sans-first:62270.85 04:41:23 INFO - PROCESS | 9185 | Values: 510.8 517.3 538.6 539.3 549.9 27412.0 34550.7 34911.1 34928.8 35016.9 41665.0 42384.2 42407.2 42490.4 42511.1 7632.9 7878.0 7879.1 7879.2 7884.9 7819.2 7953.7 7957.9 7958.4 7962.9 7905.0 7985.6 7987.6 7987.7 7987.7 7704.7 7750.2 7757.3 7762.3 7949.9 7726.3 7833.5 7841.3 7844.0 7851.5 37655.4 38098.0 38219.0 38303.4 38368.0 3007.7 3079.1 3265.2 3332.7 3385.0 28736.7 29247.0 29520.6 29932.4 30104.1 3207.0 3348.7 3364.8 3399.3 3468.7 184431.0 185500.0 186262.0 186737.0 187354.0 50101.7 53604.0 54305.7 54400.7 59003.7 52903.0 53249.0 53259.0 53360.0 53475.5 14471.5 14831.0 14832.3 14838.2 14840.6 9647.9 11140.8 11163.8 11320.4 11637.5 19538.4 20613.6 20729.0 20730.0 20742.0 7539.5 7549.4 7575.7 7671.3 7762.1 880.0 888.3 906.7 968.1 1008.9 25968.9 26938.0 27282.7 27343.3 27627.9 1001.3 1003.5 1018.6 1044.4 1061.8 13813.7 14117.9 14293.4 14310.7 14311.7 266153.0 268940.0 270707.0 272080.0 272443.0 46814.0 47362.3 47442.0 47451.3 47462.0 1207.5 1231.7 1233.9 1243.4 1250.5 26148.3 27626.2 27715.4 27972.0 28063.9 41124.2 41839.6 42125.4 42186.0 42213.6 249858.0 252891.0 253009.0 253972.0 254739.0 32592.8 32625.5 32995.8 33045.7 33453.3 41432.6 41579.4 41836.4 43737.0 45119.8 36810.3 37730.0 37964.0 37976.8 38068.0 36535.3 37509.2 38062.4 38192.8 38257.8 36107.0 37020.4 37073.4 37120.3 37151.3 32250.4 33416.8 33460.2 33463.0 34134.0 25826.7 26151.6 26183.0 26219.5 26663.6 04:41:23 INFO - PROCESS | 9185 | 04:41:23 INFO - PROCESS | 9185 | [#2] jquery.html Cycles:180 Average:22067.12 Median:4253.70 stddev:58647.96 (1378.8%) stddev-sans-first:58789.79 04:41:23 INFO - PROCESS | 9185 | Values: 336.6 337.7 344.3 349.0 351.1 14535.1 15370.6 15988.1 16010.0 16042.4 14580.6 14660.3 14776.3 15469.7 15621.0 4856.4 4986.6 5001.7 5003.4 5023.8 4859.6 4863.7 4991.5 4994.5 5050.5 4929.2 4952.3 4952.8 4960.7 4964.2 4758.6 4939.8 4940.8 4961.9 4971.1 4407.4 4409.3 4418.7 4420.0 4432.3 19095.7 19494.0 19994.9 20004.7 20032.2 1992.5 1996.3 2001.2 2138.9 2506.8 8482.4 8533.5 8642.2 8988.7 12832.9 1582.4 1633.8 1643.4 1644.2 1699.8 57230.4 61207.7 62042.7 62107.4 62773.0 8971.7 9307.0 9343.3 9371.8 9572.0 12692.7 12699.2 12787.3 12803.7 12813.1 6995.1 7230.7 7233.8 7334.8 7342.5 7006.9 7028.1 7064.1 7156.9 7178.9 4175.0 4188.8 4196.9 4221.1 4286.3 1663.8 1696.6 1721.1 1746.1 1761.4 827.2 859.5 908.9 914.1 924.5 15807.5 15968.7 16399.8 16474.6 16628.6 834.1 849.4 861.7 871.6 876.2 9212.8 9253.1 9319.4 9344.6 9396.7 289595.0 300329.0 388491.0 390057.0 397630.0 58228.7 65783.3 68757.0 70335.0 75112.6 965.8 967.8 984.2 1011.3 1019.5 14757.5 14896.2 15127.5 15342.9 15618.7 31540.4 33325.3 33485.0 34348.8 35111.8 36174.5 38661.4 38768.8 38852.2 39046.0 7354.4 7404.5 7441.9 7463.3 7494.9 8412.1 11071.6 11475.5 11577.8 11720.3 9818.4 9855.4 10092.3 10307.1 10335.3 9613.6 9961.8 10363.2 10432.5 10568.4 10417.3 10578.4 10581.8 10609.9 10624.2 7469.8 7542.2 7591.8 7598.2 7618.4 7859.3 10465.5 10502.1 10511.8 10772.5 04:41:23 INFO - PROCESS | 9185 | 04:41:23 INFO - PROCESS | 9185 | [#3] mootools.html Cycles:180 Average:5234.08 Median:6298.73 stddev:2683.18 (42.6%) stddev-sans-first:2675.29 04:41:23 INFO - PROCESS | 9185 | Values: 1407.4 1433.8 1578.0 1737.1 1803.6 7510.9 7684.2 7695.8 7703.9 7711.8 6360.0 7162.1 7382.2 7404.2 7579.9 2217.2 2255.7 2255.9 2256.0 2257.7 1930.2 2213.7 2240.0 2260.9 2266.7 2178.6 2235.7 2236.4 2238.3 2243.8 2202.8 2230.5 2247.0 2248.7 2249.9 2191.6 2197.7 2200.7 2201.1 2220.0 7552.8 7637.1 7651.2 7807.5 7817.9 4489.2 4655.2 4658.6 4659.7 4662.5 2786.7 2837.1 2937.9 2962.2 2966.0 858.0 862.4 871.2 908.4 915.8 10386.1 10405.5 10421.4 10440.9 10457.5 4175.8 4187.8 4298.2 4308.7 4318.4 8870.6 8915.0 8926.2 8928.7 8929.3 4703.1 4730.0 4732.3 4732.9 4733.9 4257.9 4259.2 4260.1 4262.9 4265.9 3320.1 3431.2 3442.8 3490.5 3492.8 1090.4 1170.2 1179.6 1206.9 1212.4 995.9 1015.6 1016.9 1085.6 1237.3 6877.9 6886.7 6893.2 6924.2 6926.0 1022.6 1028.4 1042.5 1052.1 1053.2 5455.1 5595.0 5620.4 5696.3 5703.1 8358.2 8522.1 8614.3 8659.6 8668.7 8429.4 8476.6 8519.9 8573.2 8582.9 6683.8 6796.9 6925.9 6939.8 7009.4 6912.8 6916.8 6925.4 6928.7 6928.8 7810.5 8007.8 8038.4 8164.2 8189.5 8225.8 8486.7 8501.4 8507.9 8517.4 6529.6 6758.8 6781.9 6792.1 6812.8 7001.2 7004.7 7007.8 7021.5 7036.9 5154.8 6531.8 6618.1 6735.9 6796.0 6168.5 6170.8 6286.4 6298.3 6339.1 6542.5 6601.2 6603.1 6603.8 6610.0 6265.6 6299.2 6341.7 6346.2 6352.2 6265.6 6343.0 6350.0 6365.6 6371.9 04:41:23 INFO - PROCESS | 9185 | 04:41:23 INFO - PROCESS | 9185 | [#4] prototype.html Cycles:180 Average:4702.76 Median:5395.73 stddev:1405.31 (26.0%) stddev-sans-first:1369.83 04:41:23 INFO - PROCESS | 9185 | Values: 298.9 309.9 310.4 316.8 316.9 5259.0 5373.4 5429.0 5429.4 5463.5 5327.7 5363.4 5375.0 5394.2 5397.3 3915.8 4000.7 4048.9 4145.5 4157.1 4032.5 4034.1 4102.5 4106.6 4139.7 4091.6 4098.6 4104.3 4108.0 4117.8 3918.8 4102.9 4102.9 4103.9 4112.7 3483.9 3572.8 3581.7 3586.8 3588.0 5150.7 5160.9 5175.0 5182.3 5194.8 4748.3 4752.0 4753.6 4758.6 4762.6 5661.3 5662.2 5668.3 5674.1 5677.4 3936.6 3946.0 3947.3 3951.5 3952.8 5670.0 5876.8 5950.6 5968.3 5969.7 3985.2 3989.7 4017.8 4021.8 4025.5 4065.2 4071.0 4073.2 4073.5 4074.9 4690.3 4698.5 4700.4 4708.6 4709.5 5671.2 5671.9 5676.8 5680.3 5681.0 1407.6 1434.0 1437.5 1437.9 1438.2 913.2 944.7 955.5 959.9 963.2 4828.0 4907.9 5033.9 5042.3 5090.8 5904.4 5958.9 5962.0 5970.3 5973.7 5068.3 5069.3 5069.9 5072.6 5075.2 3138.5 3175.4 3178.8 3185.7 3186.0 5614.2 5617.5 5621.9 5626.8 5627.8 5876.5 6058.1 6074.1 6096.3 6097.3 5600.7 5612.5 5624.4 5629.5 5632.2 5928.6 5935.6 5936.5 5946.2 5947.3 5781.0 5800.0 5800.8 5804.6 5824.3 5623.2 5623.4 5629.3 5629.5 5639.2 3892.2 4023.5 4035.4 4039.3 4056.6 5884.6 5885.8 5902.2 5913.1 5915.9 5720.4 5724.6 5725.6 5731.1 5734.8 5704.8 5709.3 5717.1 5726.0 5727.8 5627.3 5630.1 5635.0 5635.7 5643.7 5488.7 5690.3 5693.1 5704.4 5713.3 5548.0 5622.2 5626.0 5629.7 5636.4 04:41:23 INFO - PROCESS | 9185 | 04:41:23 INFO - PROCESS | 9185 | [#5] yui.html Cycles:180 Average:12259.83 Median:43742.56 stddev:13464.08 (30.8%) stddev-sans-first:13473.78 04:41:23 INFO - PROCESS | 9185 | Values: 683.4 756.5 772.5 777.2 789.2 10546.7 10792.8 10804.3 10817.6 10855.1 11248.9 11254.4 11285.5 11296.7 11322.8 640.6 655.3 793.0 822.8 824.6 808.1 817.5 817.9 818.8 818.8 855.8 856.2 856.6 859.6 860.7 682.2 692.8 693.3 845.7 850.3 622.8 623.1 623.2 627.2 630.2 11714.2 12196.6 12232.7 12234.1 12293.9 12377.6 12498.0 12991.7 13005.9 13086.0 9655.2 9807.3 9868.3 9873.5 9981.5 3232.1 3269.6 3283.0 3300.6 3307.2 43330.0 43409.1 43499.3 43504.0 45560.3 9674.1 9825.3 10064.8 10189.0 10328.6 16491.4 16556.4 16633.0 16677.8 16697.0 6267.0 6524.4 6566.4 6582.5 6824.8 3567.9 3639.0 3755.3 3786.1 3930.8 2765.5 2800.5 2809.8 2810.1 2817.0 505.1 523.9 530.9 562.1 589.8 545.7 581.5 599.7 601.1 611.0 7278.9 7483.2 7616.6 7764.0 8915.4 486.6 507.2 518.5 519.9 526.2 3577.5 3627.2 3713.3 3755.6 3797.2 45452.0 45860.1 46001.5 46331.0 46465.0 43981.1 44116.6 44346.3 44694.8 44707.0 35589.0 36361.8 36388.5 36436.0 36915.6 8529.8 8563.4 8620.4 8646.7 8730.8 31365.7 31753.8 31876.0 32197.0 32312.0 36592.1 38826.2 39230.2 39630.2 39824.6 9730.4 9938.0 10191.5 10327.2 10515.7 10997.9 11005.2 11393.4 11421.5 11872.9 10908.9 11138.9 11379.5 11414.7 11698.3 11419.5 11561.8 11680.5 11700.8 11762.2 10128.4 10147.2 10494.2 10555.2 11408.5 9406.7 9585.2 9686.9 9927.5 10043.1 8459.8 9399.2 9416.8 9434.4 9436.8 04:41:23 INFO - PROCESS | 9185 | -------- Summary: end -------- 04:41:23 INFO - PROCESS | 9185 | 04:41:24 INFO - TEST-INFO | 9185: exit 0 04:41:24 INFO - TEST-OK | dromaeo_css | took 1116383ms 04:41:24 INFO - TEST-START | kraken 04:41:24 INFO - operating with platform_type : linux_ 04:41:24 INFO - Initialising browser for kraken test... 04:41:24 INFO - TEST-INFO | started process 9361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHuVG73/profile http://localhost:42099/getInfo.html) 04:41:29 INFO - PROCESS | 9361 | __metrics Screen width/height:1600/1200 04:41:29 INFO - PROCESS | 9361 | colorDepth:24 04:41:29 INFO - PROCESS | 9361 | Browser inner width/height: 1024/697 04:41:29 INFO - PROCESS | 9361 | __metrics 04:41:30 ERROR - PROCESS | 9361 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:41:30 INFO - TEST-INFO | 9361: exit 0 04:41:30 INFO - Browser initialized. 04:41:30 INFO - Running cycle 1/1 for kraken test... 04:41:30 INFO - TEST-INFO | started process 9443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHuVG73/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:42 INFO - PROCESS | 9443 | RSS: Main: 154386432 04:41:42 INFO - PROCESS | 9443 | 04:41:45 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42099/tests/kraken/driver.html?testName=audio-beat-detection) 04:41:45 INFO - PROCESS | 9443 | RSS: Main: 194670592 04:41:45 INFO - PROCESS | 9443 | 04:41:48 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42099/tests/kraken/driver.html?testName=audio-dft) 04:41:49 INFO - PROCESS | 9443 | RSS: Main: 184844288 04:41:49 INFO - PROCESS | 9443 | 04:41:52 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42099/tests/kraken/driver.html?testName=audio-fft) 04:41:52 INFO - PROCESS | 9443 | RSS: Main: 170020864 04:41:52 INFO - PROCESS | 9443 | 04:41:54 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42099/tests/kraken/driver.html?testName=audio-oscillator) 04:41:55 INFO - PROCESS | 9443 | RSS: Main: 171917312 04:41:55 INFO - PROCESS | 9443 | 04:41:57 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42099/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:58 INFO - PROCESS | 9443 | RSS: Main: 173318144 04:41:58 INFO - PROCESS | 9443 | 04:42:01 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42099/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:02 INFO - PROCESS | 9443 | RSS: Main: 174055424 04:42:02 INFO - PROCESS | 9443 | 04:42:05 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42099/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:06 INFO - PROCESS | 9443 | RSS: Main: 174710784 04:42:06 INFO - PROCESS | 9443 | 04:42:08 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42099/tests/kraken/driver.html?testName=json-parse-financial) 04:42:09 INFO - PROCESS | 9443 | RSS: Main: 174534656 04:42:09 INFO - PROCESS | 9443 | 04:42:11 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42099/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:11 INFO - PROCESS | 9443 | RSS: Main: 184205312 04:42:11 INFO - PROCESS | 9443 | 04:42:13 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42099/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:14 INFO - PROCESS | 9443 | RSS: Main: 181882880 04:42:14 INFO - PROCESS | 9443 | 04:42:16 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42099/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:42:16 INFO - PROCESS | 9443 | RSS: Main: 194179072 04:42:16 INFO - PROCESS | 9443 | 04:42:19 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:20 INFO - PROCESS | 9443 | RSS: Main: 200007680 04:42:20 INFO - PROCESS | 9443 | 04:42:22 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:23 INFO - PROCESS | 9443 | RSS: Main: 199118848 04:42:23 INFO - PROCESS | 9443 | 04:42:24 INFO - PROCESS | 9443 | Cycle 1(1): loaded http://localhost:42099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42099/tests/kraken/driver.html?testName=ai-astar) 04:42:25 INFO - PROCESS | 9443 | RSS: Main: 260669440 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | __start_tp_report 04:42:25 INFO - PROCESS | 9443 | _x_x_mozilla_page_load 04:42:25 INFO - PROCESS | 9443 | _x_x_mozilla_page_load_details 04:42:25 INFO - PROCESS | 9443 | |i|pagename|runs| 04:42:25 INFO - PROCESS | 9443 | |0;ai-astar;111;112;106;112;113;114;101;112;111;112 04:42:25 INFO - PROCESS | 9443 | |1;audio-beat-detection;161;130;158;181;133;166;153;136;172;140 04:42:25 INFO - PROCESS | 9443 | |2;audio-dft;161;161;161;159;160;161;161;161;163;162 04:42:25 INFO - PROCESS | 9443 | |3;audio-fft;74;77;109;97;75;73;73;112;107;74 04:42:25 INFO - PROCESS | 9443 | |4;audio-oscillator;94;94;132;93;94;94;127;94;93;140 04:42:25 INFO - PROCESS | 9443 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;116;116 04:42:25 INFO - PROCESS | 9443 | |6;imaging-darkroom;146;145;145;146;145;146;147;146;146;146 04:42:25 INFO - PROCESS | 9443 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;96 04:42:25 INFO - PROCESS | 9443 | |8;json-parse-financial;63;63;63;64;63;64;68;75;62;67 04:42:25 INFO - PROCESS | 9443 | |9;json-stringify-tinderbox;63;63;62;63;64;64;64;63;63;64 04:42:25 INFO - PROCESS | 9443 | |10;stanford-crypto-aes;82;83;82;82;82;82;82;82;83;82 04:42:25 INFO - PROCESS | 9443 | |11;stanford-crypto-ccm;127;123;121;122;126;119;117;118;121;118 04:42:25 INFO - PROCESS | 9443 | |12;stanford-crypto-pbkdf2;142;130;156;141;143;130;155;145;131;151 04:42:25 INFO - PROCESS | 9443 | |13;stanford-crypto-sha256-iterative;70;68;69;67;69;66;67;66;69;65 04:42:25 INFO - PROCESS | 9443 | __end_tp_report 04:42:25 INFO - PROCESS | 9443 | __start_cc_report 04:42:25 INFO - PROCESS | 9443 | _x_x_mozilla_cycle_collect,1171 04:42:25 INFO - PROCESS | 9443 | __end_cc_report 04:42:25 INFO - PROCESS | 9443 | __startTimestamp1459942945241__endTimestamp 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | ------- Summary: start ------- 04:42:25 INFO - PROCESS | 9443 | Number of tests: 14 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.92 (3.5%) stddev-sans-first:4.15 04:42:25 INFO - PROCESS | 9443 | Values: 111.0 112.0 106.0 112.0 113.0 114.0 101.0 112.0 111.0 112.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:159.50 stddev:17.61 (11.0%) stddev-sans-first:18.44 04:42:25 INFO - PROCESS | 9443 | Values: 161.0 130.0 158.0 181.0 133.0 166.0 153.0 136.0 172.0 140.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 04:42:25 INFO - PROCESS | 9443 | Values: 161.0 161.0 161.0 159.0 160.0 161.0 161.0 161.0 163.0 162.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#3] audio-fft Cycles:10 Average:87.10 Median:74.00 stddev:16.94 (22.9%) stddev-sans-first:17.29 04:42:25 INFO - PROCESS | 9443 | Values: 74.0 77.0 109.0 97.0 75.0 73.0 73.0 112.0 107.0 74.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:94.00 stddev:19.23 (20.5%) stddev-sans-first:19.94 04:42:25 INFO - PROCESS | 9443 | Values: 94.0 94.0 132.0 93.0 94.0 94.0 127.0 94.0 93.0 140.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:42:25 INFO - PROCESS | 9443 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:42:25 INFO - PROCESS | 9443 | Values: 146.0 145.0 145.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:42:25 INFO - PROCESS | 9443 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:64.00 stddev:3.94 (6.2%) stddev-sans-first:4.10 04:42:25 INFO - PROCESS | 9443 | Values: 63.0 63.0 63.0 64.0 63.0 64.0 68.0 75.0 62.0 67.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 04:42:25 INFO - PROCESS | 9443 | Values: 63.0 63.0 62.0 63.0 64.0 64.0 64.0 63.0 63.0 64.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 04:42:25 INFO - PROCESS | 9443 | Values: 82.0 83.0 82.0 82.0 82.0 82.0 82.0 82.0 83.0 82.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:121.50 stddev:3.39 (2.8%) stddev-sans-first:2.88 04:42:25 INFO - PROCESS | 9443 | Values: 127.0 123.0 121.0 122.0 126.0 119.0 117.0 118.0 121.0 118.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:144.00 stddev:9.80 (6.8%) stddev-sans-first:10.39 04:42:25 INFO - PROCESS | 9443 | Values: 142.0 130.0 156.0 141.0 143.0 130.0 155.0 145.0 131.0 151.0 04:42:25 INFO - PROCESS | 9443 | 04:42:25 INFO - PROCESS | 9443 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.50 stddev:1.65 (2.4%) stddev-sans-first:1.50 04:42:25 INFO - PROCESS | 9443 | Values: 70.0 68.0 69.0 67.0 69.0 66.0 67.0 66.0 69.0 65.0 04:42:25 INFO - PROCESS | 9443 | -------- Summary: end -------- 04:42:25 INFO - PROCESS | 9443 | 04:42:26 INFO - TEST-INFO | 9443: exit 0 04:42:26 INFO - TEST-OK | kraken | took 61479ms 04:42:26 INFO - SUITE-END | took 1177s 04:42:26 INFO - Completed test suite (00:19:38) 04:42:26 INFO - javascript benchmark 04:42:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2649.549576571983, 2743.7530622243994, 2747.2445077603643, 2758.3379988802694, 2777.8055536112474, 4573.862784116473, 4652.116097941389, 4707.129181101494, 4709.7645117744105, 4723.811047558098, 4659.068186362724, 4690.413698287714, 4691.0617876424685, 4704.059188162364, 4754.120487709776, 4269.786510674469, 4315.784210789464, 4360.106178233455, 4377.518472967971, 4462.1075784843, 4404.933925991113, 4421.9336709949375, 4423.159599676052, 4473.418455600784, 4476.776161191944, 4247.086876321606, 4251.128518653669, 4339.0, 4340.7178533395545, 4363.912721745579, 4318.114786468766, 4330.480342358937, 4343.370211319341, 4389.824407023715, 4395.450568678915, 4305.870823875289, 4319.76241306728, 4323.437953066113, 4363.825446982117, 4368.170047690928, 4510.052888893337, 4593.908121837545, 4603.079384123189, 4632.467266264355, 4636.985959126595, 4923.852284431473, 4947.975260123712, 4948.67833590819, 4951.876203094916, 4956.553910148068, 4969.329140566014, 5049.293098966147, 5152.278680984665, 5177.896442071137, 5201.479852014806, 4713.764311784432, 4732.361131247307, 4733.2900064989835, 4738.810447582093, 4782.95217047832, 4914.90170196594, 5149.047426226085, 5149.6910185389, 5158.509941555546, 5159.045576568347, 4962.727050012284, 4997.775100120431, 5001.8499445016705, 5043.621728370387, 5050.924236136461, 5079.5428411443145, 5112.923306150411, 5122.334096567422, 5123.820666276662, 5170.6380553360905, 4867.829625963074, 4940.975295123573, 4989.101961646866, 5068.391792984866, 5070.645054846199, 5021.271915572294, 5045.899082018339, 5068.265101560253, 5082.161443361878, 5088.898222035538, 4286.914261714748, 4295.420118284054, 4295.570442955679, 4301.612854843079, 4337.8264869404875, 3630.8003059831435, 3782.9711357404276, 3787.4129509926006, 3799.069228039148, 3832.176082142297, 4344.869653910325, 4346.913061738811, 4394.758288294174, 4421.42521472213, 4430.800613972379, 5078.568321692624, 5107.489251074863, 5107.846764596994, 5128.692278463304, 5171.50870667286, 4304.720193187495, 4392.912141757147, 4409.162259170747, 4409.294512877924, 4459.2865141577195, 4474.664400169935, 4495.865124046284, 4507.864764057083, 4540.591346778806, 4554.63562914966, 4819.156647586588, 4824.0110777291275, 4828.299896514985, 4833.05755377698, 4838.322634831196, 4885.120678277802, 4954.9752251238515, 5094.3886733590725, 5097.133487307093, 5127.820526281712, 4861.0, 4861.854144375674, 4867.148249056472, 4887.437944636412, 4931.950680493149, 5028.362561418892, 5037.722925239001, 5039.6220283479615, 5045.243213517855, 5093.821716239914, 4934.18585933317, 4990.251462280542, 5062.746862656926, 5115.590752739698, 5185.248139019896, 4922.65541412112, 4931.580815630568, 4940.061388336205, 4952.678075925053, 4986.825461108844, 4929.014197160511, 4933.876653083558, 4934.9753251233515, 4938.037082768826, 4977.427595826526, 4800.951990480051, 4818.060478206716, 4866.659333846596, 4899.0, 4908.582770464551, 4927.8275260367145, 4930.211166213388, 4938.876528086683, 4953.380827396575, 5016.849494515171, 4828.082664293773, 4840.757962101951, 4849.393825771778, 4850.46644869057, 4903.5586797188425], "unit": "score", "name": "dojo.html", "value": 4651.9838669915025}, {"lowerIsBetter": false, "replicates": [510.82121257559857, 517.2913109040614, 538.6418032008714, 539.2800611184069, 549.8845242499074, 27412.0, 34550.65449345509, 34911.127221819464, 34928.82535587325, 35016.94949151526, 41665.0, 42384.15231695372, 42407.15185696284, 42490.36264456036, 42511.149777004444, 7632.9236707633045, 7877.960610196941, 7879.054513458364, 7879.1726868678825, 7884.881726774103, 7819.178986206452, 7953.72161974331, 7957.880631790527, 7958.442908996372, 7962.920370796276, 7904.972353594025, 7985.640646170937, 7987.5606841623685, 7987.7204297849585, 7987.7204297849585, 7704.730334438295, 7750.186230445778, 7757.301842834144, 7762.340201082915, 7949.920500794976, 7726.304632583095, 7833.49082309648, 7841.294283514511, 7844.0, 7851.45039847211, 37655.4351684725, 38098.0, 38219.04452388685, 38303.42544861829, 38368.0, 3007.6992300769966, 3079.107058952901, 3265.216348076445, 3332.6667333266723, 3384.983075084609, 28736.712632873823, 29247.0, 29520.557191642143, 29932.401351973058, 30104.09687709372, 3206.9679303206904, 3348.68187522185, 3364.798112113281, 3399.3201359728155, 3468.7051600613977, 184431.0, 185500.0, 186262.0, 186737.0, 187354.0, 50101.74949125231, 53604.0, 54305.72847135739, 54400.72799635977, 59003.70498147482, 52903.0, 53249.0, 53259.0, 53360.0, 53475.46524534783, 14471.49349772753, 14831.0, 14832.25838708082, 14838.18389988561, 14840.628984275263, 9647.9035209647, 11140.777184456265, 11163.776724465466, 11320.37737924422, 11637.534498620129, 19538.413847584594, 20613.58772824535, 20729.0, 20729.98830339185, 20742.0, 7539.547627142389, 7549.433792465477, 7575.6969721210535, 7671.2712292332135, 7762.146367643415, 879.9648014079493, 888.3426264564176, 906.7461110888962, 968.1480297338297, 1008.8700655266149, 25968.8701556491, 26938.0, 27282.72717272802, 27343.316417089733, 27627.86186069057, 1001.329109496639, 1003.4531180506641, 1018.6027449294781, 1044.3681572648438, 1061.8354155105972, 13813.723725525635, 14117.858821411859, 14293.356798944073, 14310.713785724227, 14311.713765724835, 266153.0, 268940.0, 270707.0, 272080.0, 272443.0, 46814.0, 47362.289565656545, 47442.0, 47451.28823067657, 47462.0, 1207.5169932027259, 1231.6797632615585, 1233.858106317767, 1243.3720970909815, 1250.481050364107, 26148.34629134287, 27626.171214863585, 27715.44569108566, 27972.0, 28063.859680702284, 41124.1775164501, 41839.58160418357, 42125.368119478844, 42186.0, 42213.57786422219, 249858.0, 252891.0, 253009.0, 253972.0, 254739.0, 32592.837035814668, 32625.510617340286, 32995.8350208257, 33045.66954330522, 33453.33093338168, 41432.58567414408, 41579.37630935599, 41836.37245441382, 43737.0, 45119.77440112778, 36810.26379472342, 37730.0, 37964.0, 37976.81011595035, 38068.0, 36535.26929461449, 37509.24981500409, 38062.42906356351, 38192.80903595464, 38257.80871095627, 36107.0, 37020.44469333016, 37073.44389834101, 37120.28797120266, 37151.25697485981, 32250.35499290048, 33416.83291583624, 33460.1634959128, 33463.0, 34134.0, 25826.741732582435, 26151.607725884507, 26183.0, 26219.475610488065, 26663.600045999712], "unit": "score", "name": "ext.html", "value": 17343.270742184868}, {"lowerIsBetter": false, "replicates": [336.56583007919784, 337.70450855501434, 344.338869370808, 349.0331780966721, 351.1169408936525, 14535.055221410614, 15370.615734606627, 15988.12065336406, 16010.0, 16042.35830566776, 14580.562583122497, 14660.340284687189, 14776.261186940663, 15469.690606187869, 15621.0, 4856.368672072635, 4986.5761410280165, 5001.7499125043605, 5003.374578177728, 5023.8492845214705, 4859.562639362457, 4863.683860549053, 4991.500849915015, 4994.500549945013, 5050.545450909417, 4929.21132618781, 4952.331435256248, 4952.826651067214, 4960.70235785854, 4964.15609346412, 4758.595519380857, 4939.753012349386, 4940.7776650050655, 4961.900761984776, 4971.105201063807, 4407.360932664746, 4409.294512877924, 4418.734875907456, 4419.955800441987, 4432.268675668511, 19095.713564296548, 19494.0, 19994.900025499926, 20004.69992950107, 20032.1987120515, 1992.4520756791853, 1996.291316582607, 2001.2195243854908, 2138.9358319250446, 2506.7994560435304, 8482.36382271326, 8533.487990720576, 8642.178992995656, 8988.685396011108, 12832.935835320764, 1582.4461438496548, 1633.8447847454472, 1643.4165871115702, 1644.161477646409, 1699.7620333153245, 57230.427695723345, 61207.693961529905, 62042.68978655123, 62107.378926210615, 62773.0, 8971.730848074569, 9306.953465232766, 9343.2525397968, 9371.765705857408, 9571.952140239255, 12692.746145077046, 12699.174553653984, 12787.296698681475, 12803.743925121631, 12813.103082784115, 6995.125609298838, 7230.674619642129, 7233.819154521074, 7334.779956601311, 7342.5227360221415, 7006.859862802818, 7028.051213086168, 7064.116985376828, 7156.92843071573, 7178.892316615255, 4175.0, 4188.790560472025, 4196.9370459443135, 4221.092465120014, 4286.314189729628, 1663.8252983436564, 1696.6182608912895, 1721.1308289314068, 1746.05712915027, 1761.4011236179504, 827.1825525201153, 859.5186695450568, 908.8954770201511, 914.0996118822954, 924.4684306523776, 15807.525774226791, 15968.658334874228, 16399.754003689955, 16474.588135296475, 16628.58428539296, 834.1200033964226, 849.4436144325476, 861.7371701631063, 871.581361721216, 876.1982785750967, 9212.769680758034, 9253.120953509406, 9319.394239374418, 9344.579493922789, 9396.718098457057, 289595.0, 300329.0, 388491.0, 390057.0, 397630.0, 58228.70885645544, 65783.34216657773, 68757.0, 70335.0, 75112.62443687856, 965.8454647256546, 967.7725734452398, 984.2027957354566, 1011.2870426349406, 1019.50553981319, 14757.483488077865, 14896.180710061051, 15127.470538531099, 15342.923285383948, 15618.687626247183, 31540.36919261648, 33325.33349333048, 33485.0, 34348.82825585856, 35111.82444087763, 36174.4573831398, 38661.420078699404, 38768.80615596904, 38852.2229555413, 39046.0, 7354.411647068328, 7404.518706284074, 7441.851162976818, 7463.2909873564095, 7494.887576686245, 8412.116727743498, 11071.612493562687, 11475.540978360772, 11577.826332605186, 11720.296782193096, 9818.410895346302, 9855.408675479493, 10092.293539452168, 10307.123894469054, 10335.276530642783, 9613.615455381707, 9961.800763984824, 10363.170946324126, 10432.530536125741, 10568.418736969541, 10417.322874013165, 10578.365298082139, 10581.788364232827, 10609.8939010612, 10624.150067994697, 7469.813254668677, 7542.245775422633, 7591.848163036598, 7598.240175982358, 7618.352440042437, 7859.331956783737, 10465.529051192867, 10502.10732087781, 10511.842322365017, 10772.515236814206], "unit": "score", "name": "jquery.html", "value": 7803.770868114849}, {"lowerIsBetter": false, "replicates": [1407.429990853704, 1433.8351089624693, 1577.9684406311874, 1737.088028784887, 1803.6302557975616, 7510.887336689947, 7684.231576842313, 7695.846083078335, 7703.884441733371, 7711.807204819876, 6360.045993101037, 7162.1405431348185, 7382.18795932447, 7404.222556631544, 7579.924200757991, 2217.246136313653, 2255.729312482496, 2255.875926824024, 2256.0411824974403, 2257.7064981552376, 1930.2472035906007, 2213.7454192767796, 2240.0, 2260.8756518391483, 2266.6713326567638, 2178.6187417202004, 2235.6870038194666, 2236.39617303328, 2238.3173132194675, 2243.7644047375034, 2202.79947428651, 2230.4981379189717, 2246.9550608987893, 2248.662700594924, 2249.8875056247202, 2191.583599116179, 2197.747259065212, 2200.7359116905914, 2201.119552179125, 2219.966700499494, 7552.811179720496, 7637.083549973983, 7651.196624354418, 7807.492512986638, 7817.8827317590285, 4489.214387482178, 4655.185342565038, 4658.604018658418, 4659.743714095724, 4662.53374662531, 2786.749192572678, 2837.092130518235, 2937.8971735989353, 2962.22982024673, 2966.0, 857.9914200857974, 862.4178679391448, 871.2072014466868, 908.4413085952092, 915.8031023330016, 10386.065254127165, 10405.47972601367, 10421.374717516897, 10440.895591044069, 10457.477126143738, 4175.812088455966, 4187.811548480326, 4298.20483210607, 4308.698391112592, 4318.41701370311, 8870.600822962982, 8915.0, 8926.152015558511, 8928.687495937611, 8929.33030022751, 4703.082898834763, 4729.976350118296, 4732.290156476487, 4732.905341893143, 4733.881652958704, 4257.893552661209, 4259.169461954951, 4260.147970405931, 4262.914741705148, 4265.850695225652, 3320.0869760815967, 3431.227973705896, 3442.7934323940644, 3490.458978858281, 3492.7555071144775, 1090.3566895531517, 1170.1808733886144, 1179.5871444994355, 1206.879312068786, 1212.4362171590076, 995.8854731705802, 1015.603914473356, 1016.9440680762481, 1085.5874767588266, 1237.2638280223252, 6877.862442751117, 6886.655667216619, 6893.20728116263, 6924.203716572558, 6926.0, 1022.5858527296457, 1028.4035259549444, 1042.4839704346398, 1052.1109662335314, 1053.2364036073784, 5455.072637651609, 5595.048841696921, 5620.381758006616, 5696.287964004499, 5703.144528320702, 8358.164183581594, 8522.062573116953, 8614.267787238156, 8659.610317535726, 8668.739937801876, 8429.40994130405, 8476.618552165168, 8519.872201916976, 8573.18554737299, 8582.87125693115, 6683.7660681875905, 6796.898046529207, 6925.861482770317, 6939.757108501179, 7009.369156775812, 6912.792616221522, 6916.827079323057, 6925.445964322741, 6928.7228510859, 6928.757493487704, 7810.531368117704, 8007.799805004922, 8038.437309388287, 8164.224398682116, 8189.549574773445, 8225.79435514117, 8486.660533578588, 8501.404901656824, 8507.8723819144, 8517.403781735218, 6529.575577587441, 6758.797236082925, 6781.89827152603, 6792.083068785848, 6812.795616131524, 7001.229864714979, 7004.684789184397, 7007.789766307019, 7021.508494405342, 7036.9296307036275, 5154.819581314786, 6531.836704082246, 6618.073469714148, 6735.898961515483, 6795.966020169867, 6168.506519478341, 6170.753169873155, 6286.37136286386, 6298.275698294755, 6339.144215530844, 6542.509311801538, 6601.24085730128, 6603.075569420189, 6603.768868089786, 6610.041543976193, 6265.561410701207, 6299.181106456132, 6341.682915854097, 6346.2067241594805, 6352.205974253218, 6265.592736472115, 6343.016832390987, 6350.0, 6365.618062916054, 6371.936280637135], "unit": "score", "name": "mootools.html", "value": 4310.467015562771}, {"lowerIsBetter": false, "replicates": [298.852068226228, 309.9225193701574, 310.3591084410692, 316.80358177929656, 316.8922566327447, 5258.973705131479, 5373.382061062979, 5429.049916264647, 5429.429909859467, 5463.535599474039, 5327.653702509334, 5363.410024897258, 5375.0, 5394.163904594784, 5397.298351214346, 3915.804209789513, 4000.6999475039343, 4048.9190216195657, 4145.461090058288, 4157.106222162234, 4032.475778148851, 4034.112495251055, 4102.543597023058, 4106.568810274923, 4139.668826493888, 4091.5703851095504, 4098.631123198911, 4104.302268614328, 4107.979460102695, 4117.773522456278, 3918.804059797027, 4102.856400025999, 4102.938455923164, 4103.8974025649295, 4112.732672376316, 3483.860645574174, 3572.821358932069, 3581.6776490116013, 3586.8027258500774, 3588.0, 5150.742462876879, 5160.91620759641, 5175.0, 5182.274481572583, 5194.766235519411, 4748.3114948332295, 4751.976240118777, 4753.595944344735, 4758.61931045519, 4762.571368576845, 5661.320641523002, 5662.207290979266, 5668.31980162379, 5674.120511320752, 5677.432256774289, 3936.5866584008554, 3946.0, 3947.2697550953167, 3951.5060617422823, 3952.7628342299554, 5670.0, 5876.794312199053, 5950.5834591578605, 5968.343482216953, 5969.671668058255, 3985.1830374773103, 3989.68082553395, 4017.83928642851, 4021.8391264349098, 4025.5169379674626, 4065.207284579538, 4071.0229544909603, 4073.165001174752, 4073.51117865858, 4074.898127546776, 4690.296455531698, 4698.459677137104, 4700.435947686231, 4708.576228139484, 4709.529047095331, 5671.2060311556415, 5671.943280567141, 5676.801311954062, 5680.318361796528, 5681.005823980787, 1407.5847624950663, 1434.0033676594667, 1437.525616546537, 1437.9352929118215, 1438.2449214162439, 913.1872633356318, 944.730751735752, 955.47926380123, 959.8992105828927, 963.1861077389594, 4827.975860120747, 4907.901841963141, 5033.899322013613, 5042.294078828967, 5090.796368145233, 5904.380040095728, 5958.880822383528, 5962.0, 5970.283565972111, 5973.701314934236, 5068.265101560253, 5069.264956581275, 5069.949300507022, 5072.644914855925, 5075.187969924795, 3138.450771115046, 3175.4442972479724, 3178.8251646159683, 3185.7132858042887, 3185.9681403185673, 5614.1859430382365, 5617.466340697627, 5621.887562248814, 5626.831195064155, 5627.803026894039, 5876.529877609781, 6058.091286307089, 6074.119252708332, 6096.298925623521, 6097.298810636745, 5600.691961942132, 5612.494875461228, 5624.3813180550105, 5629.4652008059165, 5632.183333416549, 5928.555358348228, 5935.643861368331, 5936.525077993837, 5946.167536544974, 5947.256592925884, 5780.971095144498, 5799.971000144972, 5800.76796928135, 5804.593678442468, 5824.301083869963, 5623.2408624835125, 5623.437656234344, 5629.296337957755, 5629.4652008059165, 5639.238702775237, 3892.2410130024373, 4023.4568333275806, 4035.4350390944705, 4039.2729308723538, 4056.5537790843573, 5884.6469211847425, 5885.793997210249, 5902.173695682522, 5913.083472061838, 5915.940840591539, 5720.3707592165665, 5724.570657200643, 5725.599208055396, 5731.140328950691, 5734.770609175586, 5704.80033198836, 5709.286339207599, 5717.085266357363, 5726.026575482095, 5727.799527016535, 5627.324721033502, 5630.0991841305195, 5635.0, 5635.718214089361, 5643.71781410936, 5488.725563721878, 5690.345610254708, 5693.146028095819, 5704.401037891128, 5713.257276554022, 5547.972260138674, 5622.2128901954575, 5625.971870140623, 5629.746661400329, 5636.351819540805], "unit": "score", "name": "prototype.html", "value": 4249.156154025386}, {"lowerIsBetter": false, "replicates": [683.4464084091885, 756.4591317208196, 772.4554189296547, 777.1529033353647, 789.1595450844846, 10546.683599492018, 10792.78414431711, 10804.297720648152, 10817.567297308098, 10855.077318427933, 11248.887511124887, 11254.381009044499, 11285.492152853121, 11296.661100166988, 11322.773544529104, 640.586821500131, 655.3217419970332, 792.9801754956114, 822.7819627798638, 824.6083110522513, 808.0666829811547, 817.456391499655, 817.8691409374501, 818.8034871630796, 818.8157664525494, 855.7732200966749, 856.195176534056, 856.5545916123612, 859.5788063848731, 860.7202659135775, 682.2086379799433, 692.7713854428026, 693.2686016252851, 845.7082306604211, 850.2602735620019, 622.7508996401431, 623.1245100633618, 623.2365352443267, 627.1971875998729, 630.1964994631835, 11714.23857449263, 12196.634100976986, 12232.694182645417, 12234.08244381675, 12293.938530307381, 12377.566785162477, 12498.0, 12991.740165196738, 13005.86994130056, 13086.0, 9655.17930975868, 9807.26445516589, 9868.259880508991, 9873.506324683736, 9981.500924953796, 3232.127325622069, 3269.64309811428, 3282.96717032829, 3300.5709257796575, 3307.206270495088, 43330.0, 43409.13181736379, 43499.34750978738, 43504.0, 45560.3165952511, 9674.129328360481, 9825.263105267133, 10064.849027264598, 10189.0, 10328.586856525655, 16491.422800201934, 16556.42052528156, 16633.0, 16677.833221667872, 16697.0, 6267.0, 6524.412802847766, 6566.409023187841, 6582.539222254492, 6824.7952561423235, 3567.9108022299133, 3639.0224976746395, 3755.3240416724707, 3786.072412259014, 3930.8427662893737, 2765.4745598336253, 2800.495910736087, 2809.803313768017, 2810.1429064135227, 2816.971830281671, 505.0883155903556, 523.9371275446971, 530.936287645485, 562.0725802425948, 589.8289496046184, 545.6916841984346, 581.4824805922732, 599.66718471248, 601.0653433910311, 610.971574373086, 7278.871774874903, 7483.176850546435, 7616.645146495055, 7764.0, 8915.42049766763, 486.60584926209884, 507.2214151277771, 518.4996478398364, 519.948005199477, 526.2369564132024, 3577.5170352002665, 3627.183883626216, 3713.294474049922, 3755.605661405568, 3797.240551889633, 45452.0, 45860.08279834384, 46001.53998459972, 46331.0, 46465.0, 43981.12037759227, 44116.55883441189, 44346.334804977305, 44694.77652611716, 44707.0, 35589.0, 36361.818190908874, 36388.45417318743, 36436.0, 36915.63084369175, 8529.82940341202, 8563.400561960603, 8620.353473489638, 8646.697365592174, 8730.825383492422, 31365.686343136276, 31753.841230794624, 31876.0, 32197.0, 32312.0, 36592.0851978692, 38826.22347552977, 39230.21539569135, 39630.20739585134, 39824.60175398209, 9730.41617502952, 9938.0, 10191.54138063774, 10327.225458090523, 10515.737106572396, 10997.945010274898, 11005.17461190398, 11393.430328483377, 11421.543138274375, 11872.881271187178, 10908.945455272673, 11138.944305278746, 11379.487923043649, 11414.657560273205, 11698.2981021139, 11419.486123124314, 11561.826572601249, 11680.532778689098, 11700.765984680429, 11762.235454695418, 10128.392296462236, 10147.238957078396, 10494.21293403013, 10555.208359373231, 11408.486618102039, 9406.717798466058, 9585.233181345615, 9686.9031309686, 9927.503624818875, 10043.146332561522, 8459.83080338402, 9399.201067909304, 9416.764580885532, 9434.433933963985, 9436.764080898032], "unit": "score", "name": "yui.html", "value": 5800.441629774855}], "name": "dromaeo_css", "value": 6371.388888694099}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 112.0, 113.0, 114.0, 101.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [161.0, 130.0, 158.0, 181.0, 133.0, 166.0, 153.0, 136.0, 172.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 153.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 159.0, 160.0, 161.0, 161.0, 161.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 109.0, 97.0, 75.0, 73.0, 73.0, 112.0, 107.0, 74.0], "unit": "score", "name": "audio-fft", "value": 87.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 132.0, 93.0, 94.0, 94.0, 127.0, 94.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 68.0, 75.0, 62.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 65.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 62.0, 63.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.3}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 82.0, 82.0, 82.0, 82.0, 82.0, 82.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [127.0, 123.0, 121.0, 122.0, 126.0, 119.0, 117.0, 118.0, 121.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [142.0, 130.0, 156.0, 141.0, 143.0, 130.0, 155.0, 145.0, 131.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 67.0, 69.0, 66.0, 67.0, 66.0, 69.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1516.5000000000002}]} 04:42:26 INFO - Return code: 0 04:42:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:42:26 ERROR - # TBPL SUCCESS # 04:42:26 INFO - Running post-action listener: _resource_record_post_action 04:42:26 INFO - Running post-run listener: _resource_record_post_run 04:42:27 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 352256; Write bytes: 288747520; Read time: 132; Write time: 215068 04:42:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6356992; Read time: 0; Write time: 428 04:42:27 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 352256; Write bytes: 282390528; Read time: 132; Write time: 214640 04:42:27 INFO - Running post-run listener: _upload_blobber_files 04:42:27 INFO - Blob upload gear active. 04:42:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:42:27 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 04:42:27 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:42:27 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:42:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:28 INFO - (blobuploader) - INFO - Done attempting. 04:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:29 INFO - (blobuploader) - INFO - Done attempting. 04:42:29 INFO - (blobuploader) - INFO - Iteration through files over. 04:42:29 INFO - Return code: 0 04:42:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:42:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:42:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/829770d17e5927aa0bcf58565b9cb42a144212e1b7700d41dca854b3530f45679456a1b068ee6d513af859b8eb3b7175602e56af176b610a31b7c2e47fdae334", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57e6eb52966e1a67e8ac7e4fbe5aa0858dd9f325080b874aa864840c499a6ab7a98f4025bc205310cb7805da9659576ec84250f0584369d5966212b09e8a5425"} 04:42:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:42:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:42:29 INFO - Contents: 04:42:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/829770d17e5927aa0bcf58565b9cb42a144212e1b7700d41dca854b3530f45679456a1b068ee6d513af859b8eb3b7175602e56af176b610a31b7c2e47fdae334", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57e6eb52966e1a67e8ac7e4fbe5aa0858dd9f325080b874aa864840c499a6ab7a98f4025bc205310cb7805da9659576ec84250f0584369d5966212b09e8a5425"} 04:42:29 INFO - Running post-run listener: copy_logs_to_upload_dir 04:42:29 INFO - Copying logs to upload dir... 04:42:29 INFO - mkdir: /builds/slave/test/build/upload/logs 04:42:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.681392 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-06 04:42:29.643825) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 04:42:29.647018) ========= 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=574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/829770d17e5927aa0bcf58565b9cb42a144212e1b7700d41dca854b3530f45679456a1b068ee6d513af859b8eb3b7175602e56af176b610a31b7c2e47fdae334", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57e6eb52966e1a67e8ac7e4fbe5aa0858dd9f325080b874aa864840c499a6ab7a98f4025bc205310cb7805da9659576ec84250f0584369d5966212b09e8a5425"} build_url:https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/LtD-JvWiQ7-cmEvGsT1YiA/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/Firefox-Non-PGO/sha512/829770d17e5927aa0bcf58565b9cb42a144212e1b7700d41dca854b3530f45679456a1b068ee6d513af859b8eb3b7175602e56af176b610a31b7c2e47fdae334", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57e6eb52966e1a67e8ac7e4fbe5aa0858dd9f325080b874aa864840c499a6ab7a98f4025bc205310cb7805da9659576ec84250f0584369d5966212b09e8a5425"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 04:42:29.671045) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:42:29.671345) ========= 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=574dc5aafe09851ec43d388c000001b6-1459941407.149304-900524611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:42:29.757426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 04:42:29.757745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 04:42:29.758052) ========= ========= Total master_lag: 0.26 =========