builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1458175624.63 results: success (0) buildid: 20160316163410 builduid: 39e78053619f4707b16713ab2a71836e revision: 20218dd51efaa84dcb1f2e98f08e851a9bf299e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.629275) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.629834) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.630367) ========= 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=6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006514 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.657583) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.657911) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.681009) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.681332) ========= 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=6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004677 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.738838) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.739157) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.739586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.739908) ========= 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=6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-16 17:47:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-03-16 17:47:05 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.913580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.913897) ========= 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=6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020366 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.976378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:04.976729) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 20218dd51efaa84dcb1f2e98f08e851a9bf299e3 --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 20218dd51efaa84dcb1f2e98f08e851a9bf299e3 --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=6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-16 17:47:05,796 truncating revision to first 12 chars 2016-03-16 17:47:05,796 Setting DEBUG logging. 2016-03-16 17:47:05,796 attempt 1/10 2016-03-16 17:47:05,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/20218dd51efa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 17:47:06,094 unpacking tar archive at: mozilla-central-20218dd51efa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615544 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:05.605261) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:05.605608) ========= echo 20218dd51efaa84dcb1f2e98f08e851a9bf299e3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'20218dd51efaa84dcb1f2e98f08e851a9bf299e3'] 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=6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20218dd51efaa84dcb1f2e98f08e851a9bf299e3 program finished with exit code 0 elapsedTime=0.004716 script_repo_revision: '20218dd51efaa84dcb1f2e98f08e851a9bf299e3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:05.656943) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:05.657293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 17:47:05.667460) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-16 17:47:05.667836) ========= /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=6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:47:06 INFO - MultiFileLogger online at 20160316 17:47:06 in /builds/slave/test 17:47:06 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 17:47:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:47:06 INFO - {'append_to_log': False, 17:47:06 INFO - 'base_work_dir': '/builds/slave/test', 17:47:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:47:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:47:06 INFO - 'branch': 'Firefox-Non-PGO', 17:47:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:47:06 INFO - 'config_files': ('talos/linux_config.py',), 17:47:06 INFO - 'default_actions': ('clobber', 17:47:06 INFO - 'read-buildbot-config', 17:47:06 INFO - 'download-and-extract', 17:47:06 INFO - 'populate-webroot', 17:47:06 INFO - 'create-virtualenv', 17:47:06 INFO - 'install', 17:47:06 INFO - 'run-tests'), 17:47:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:47:06 INFO - 'download_minidump_stackwalk': True, 17:47:06 INFO - 'download_symbols': 'ondemand', 17:47:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:47:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:47:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:47:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:47:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:47:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:47:06 INFO - 'installer_path': 'installer.exe', 17:47:06 INFO - 'log_level': 'info', 17:47:06 INFO - 'log_name': 'talos', 17:47:06 INFO - 'log_to_console': True, 17:47:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:47:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:47:06 INFO - 'opt_config_files': (), 17:47:06 INFO - 'pip_index': False, 17:47:06 INFO - 'sps_profile': False, 17:47:06 INFO - 'sps_profile_interval': 0, 17:47:06 INFO - 'suite': 'dromaeojs', 17:47:06 INFO - 'system_bits': '32', 17:47:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:47:06 INFO - 'title': 'talos-linux64-ix-050', 17:47:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:47:06 INFO - 'use_talos_json': True, 17:47:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:47:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:47:06 INFO - 'work_dir': 'build'} 17:47:06 INFO - ##### 17:47:06 INFO - ##### Running clobber step. 17:47:06 INFO - ##### 17:47:06 INFO - Running pre-action listener: _resource_record_pre_action 17:47:06 INFO - Running main action method: clobber 17:47:06 INFO - rmtree: /builds/slave/test/build 17:47:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:47:07 INFO - Running post-action listener: _resource_record_post_action 17:47:07 INFO - ##### 17:47:07 INFO - ##### Running read-buildbot-config step. 17:47:07 INFO - ##### 17:47:07 INFO - Running pre-action listener: _resource_record_pre_action 17:47:07 INFO - Running main action method: read_buildbot_config 17:47:07 INFO - Using buildbot properties: 17:47:07 INFO - { 17:47:07 INFO - "project": "", 17:47:07 INFO - "product": "firefox", 17:47:07 INFO - "script_repo_revision": "production", 17:47:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:47:07 INFO - "repository": "", 17:47:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:47:07 INFO - "buildid": "20160316163410", 17:47:07 INFO - "pgo_build": "False", 17:47:07 INFO - "basedir": "/builds/slave/test", 17:47:07 INFO - "buildnumber": 37, 17:47:07 INFO - "slavename": "talos-linux64-ix-050", 17:47:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:47:07 INFO - "platform": "ubuntu64_hw", 17:47:07 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:47:07 INFO - "branch": "mozilla-central", 17:47:07 INFO - "repo_path": "mozilla-central", 17:47:07 INFO - "revision": "20218dd51efaa84dcb1f2e98f08e851a9bf299e3", 17:47:07 INFO - "stage_platform": "linux64", 17:47:07 INFO - "builduid": "39e78053619f4707b16713ab2a71836e", 17:47:07 INFO - "slavebuilddir": "test" 17:47:07 INFO - } 17:47:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:47:07 INFO - Running post-action listener: _resource_record_post_action 17:47:07 INFO - ##### 17:47:07 INFO - ##### Running download-and-extract step. 17:47:07 INFO - ##### 17:47:07 INFO - Running pre-action listener: _resource_record_pre_action 17:47:07 INFO - Running main action method: download_and_extract 17:47:07 INFO - mkdir: /builds/slave/test/build/tests 17:47:07 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')]} 17:47:07 INFO - https://queue.taskcluster.net/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:47:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:47:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:47:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/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 17:47:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/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 17:47:08 INFO - Downloaded 1361 bytes. 17:47:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:47:08 INFO - Using the following test package requirements: 17:47:08 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:47:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:47:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:47:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:08 INFO - u'jsshell-linux-x86_64.zip'], 17:47:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:47:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:47:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:47:08 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:47:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:47:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:47:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:47:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:47:08 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')]} 17:47:08 INFO - https://queue.taskcluster.net/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:47:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:47:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:47:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/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 17:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/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 17:47:10 INFO - Downloaded 21993450 bytes. 17:47:10 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'] 17:47:10 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 17:47:11 INFO - Return code: 0 17:47:11 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 17:47:11 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')]} 17:47:11 INFO - https://queue.taskcluster.net/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:47:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:47:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:47:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/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 17:47:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/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 17:47:14 INFO - Downloaded 21993450 bytes. 17:47:14 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'] 17:47:14 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 17:47:15 INFO - Return code: 0 17:47:15 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')]} 17:47:15 INFO - https://queue.taskcluster.net/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:47:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:47:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:47:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/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 17:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/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 17:47:16 INFO - Downloaded 10846462 bytes. 17:47:16 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'] 17:47:16 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 17:47:16 INFO - Return code: 0 17:47:16 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')]} 17:47:16 INFO - https://queue.taskcluster.net/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:47:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:47:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:47:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/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 17:47:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/As1fkxKDQYigrDPAvN1aMg/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 17:47:18 INFO - Downloaded 54125144 bytes. 17:47:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:47:18 INFO - mkdir: /builds/slave/test/properties 17:47:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:47:18 INFO - Writing to file /builds/slave/test/properties/build_url 17:47:18 INFO - Contents: 17:47:18 INFO - build_url:https://queue.taskcluster.net/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:47:19 INFO - Running post-action listener: _resource_record_post_action 17:47:19 INFO - Running post-action listener: set_extra_try_arguments 17:47:19 INFO - ##### 17:47:19 INFO - ##### Running populate-webroot step. 17:47:19 INFO - ##### 17:47:19 INFO - Running pre-action listener: _resource_record_pre_action 17:47:19 INFO - Running main action method: populate_webroot 17:47:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:47:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:47:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:47:19 INFO - '--tppagecycles', 17:47:19 INFO - '7'], 17:47:19 INFO - 'tests': ['tsvgm']}}, 17:47:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:47:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:47:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:47:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:47:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:47:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:47:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:19 INFO - 'talos_options': ['--e10s'], 17:47:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:19 INFO - 'tests': ['damp', 'tps']}, 17:47:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:19 INFO - 'talos_options': ['--e10s'], 17:47:19 INFO - 'tests': ['damp', 'tps']}, 17:47:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:47:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:47:19 INFO - 'other': {'tests': ['a11yr', 17:47:19 INFO - 'ts_paint', 17:47:19 INFO - 'tpaint', 17:47:19 INFO - 'sessionrestore', 17:47:19 INFO - 'sessionrestore_no_auto_restore', 17:47:19 INFO - 'tabpaint']}, 17:47:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:47:19 INFO - 'tests': ['a11yr', 17:47:19 INFO - 'ts_paint', 17:47:19 INFO - 'tpaint', 17:47:19 INFO - 'sessionrestore', 17:47:19 INFO - 'sessionrestore_no_auto_restore', 17:47:19 INFO - 'tabpaint']}, 17:47:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:47:19 INFO - 'tests': ['a11yr', 17:47:19 INFO - 'ts_paint', 17:47:19 INFO - 'tpaint', 17:47:19 INFO - 'sessionrestore', 17:47:19 INFO - 'sessionrestore_no_auto_restore', 17:47:19 INFO - 'tabpaint']}, 17:47:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:47:19 INFO - 'tests': ['a11yr', 17:47:19 INFO - 'ts_paint', 17:47:19 INFO - 'tpaint', 17:47:19 INFO - 'sessionrestore', 17:47:19 INFO - 'sessionrestore_no_auto_restore', 17:47:19 INFO - 'tabpaint']}, 17:47:19 INFO - 'other_l64': {'tests': ['a11yr', 17:47:19 INFO - 'ts_paint', 17:47:19 INFO - 'tpaint', 17:47:19 INFO - 'sessionrestore', 17:47:19 INFO - 'sessionrestore_no_auto_restore', 17:47:19 INFO - 'tabpaint']}, 17:47:19 INFO - 'other_nol64': {'tests': ['a11yr', 17:47:19 INFO - 'ts_paint', 17:47:19 INFO - 'tpaint', 17:47:19 INFO - 'sessionrestore', 17:47:19 INFO - 'sessionrestore_no_auto_restore', 17:47:19 INFO - 'tabpaint']}, 17:47:19 INFO - 'svgr': {'tests': ['tsvgx', 17:47:19 INFO - 'tsvgr_opacity', 17:47:19 INFO - 'tart', 17:47:19 INFO - 'tscrollx', 17:47:19 INFO - 'cart']}, 17:47:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:47:19 INFO - 'tests': ['tsvgx', 17:47:19 INFO - 'tsvgr_opacity', 17:47:19 INFO - 'tart', 17:47:19 INFO - 'tscrollx', 17:47:19 INFO - 'cart']}, 17:47:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:19 INFO - 'tests': ['tp5o']}, 17:47:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:19 INFO - 'talos_options': ['--e10s'], 17:47:19 INFO - 'tests': ['tp5o']}, 17:47:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:19 INFO - 'talos_options': ['--xperf_path', 17:47:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:19 INFO - 'tests': ['tp5n']}, 17:47:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:19 INFO - 'talos_options': ['--e10s', 17:47:19 INFO - '--xperf_path', 17:47:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:19 INFO - 'tests': ['tp5n']}}, 17:47:19 INFO - 'talos.zip': {'path': '', 17:47:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:47:19 INFO - Running post-action listener: _resource_record_post_action 17:47:19 INFO - ##### 17:47:19 INFO - ##### Running create-virtualenv step. 17:47:19 INFO - ##### 17:47:19 INFO - Running pre-action listener: _resource_record_pre_action 17:47:19 INFO - Running main action method: create_virtualenv 17:47:19 INFO - Creating virtualenv /builds/slave/test/build/venv 17:47:19 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 17:47:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:47:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:47:19 INFO - Using real prefix '/usr' 17:47:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:47:19 INFO - Installing distribute.............................................................................................................................................................................................done. 17:47:21 INFO - Installing pip.................done. 17:47:21 INFO - Return code: 0 17:47:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:21 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 0x7f60a0e58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140c160>, '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 0x140d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140d4f0>, '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': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', '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 17:47:21 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 17:47:21 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 17:47:21 INFO - Using env: {'DISPLAY': ':0', 17:47:21 INFO - 'HOME': '/home/cltbld', 17:47:21 INFO - 'LANG': 'en_US.UTF-8', 17:47:21 INFO - 'LANGUAGE': 'en_US:en', 17:47:21 INFO - 'LOGNAME': 'cltbld', 17:47:21 INFO - 'MAIL': '/var/mail/cltbld', 17:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:21 INFO - 'MOZ_NO_REMOTE': '1', 17:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:21 INFO - 'NO_EM_RESTART': '1', 17:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:21 INFO - 'PWD': '/builds/slave/test', 17:47:21 INFO - 'SHELL': '/bin/bash', 17:47:21 INFO - 'SHLVL': '1', 17:47:21 INFO - 'TERM': 'linux', 17:47:21 INFO - 'TMOUT': '86400', 17:47:21 INFO - 'USER': 'cltbld', 17:47:21 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', 17:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:21 INFO - '_': '/tools/buildbot/bin/python'} 17:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:22 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 17:47:22 INFO - Cleaning up... 17:47:22 INFO - Return code: 0 17:47:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:22 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 0x7f60a0e58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140c160>, '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 0x140d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140d4f0>, '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': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', '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 17:47:22 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 17:47:22 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 17:47:22 INFO - Using env: {'DISPLAY': ':0', 17:47:22 INFO - 'HOME': '/home/cltbld', 17:47:22 INFO - 'LANG': 'en_US.UTF-8', 17:47:22 INFO - 'LANGUAGE': 'en_US:en', 17:47:22 INFO - 'LOGNAME': 'cltbld', 17:47:22 INFO - 'MAIL': '/var/mail/cltbld', 17:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:22 INFO - 'MOZ_NO_REMOTE': '1', 17:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:22 INFO - 'NO_EM_RESTART': '1', 17:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:22 INFO - 'PWD': '/builds/slave/test', 17:47:22 INFO - 'SHELL': '/bin/bash', 17:47:22 INFO - 'SHLVL': '1', 17:47:22 INFO - 'TERM': 'linux', 17:47:22 INFO - 'TMOUT': '86400', 17:47:22 INFO - 'USER': 'cltbld', 17:47:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', 17:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:22 INFO - '_': '/tools/buildbot/bin/python'} 17:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:22 INFO - Downloading/unpacking psutil>=0.7.1 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:47:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:24 INFO - Installing collected packages: psutil 17:47:24 INFO - Running setup.py install for psutil 17:47:24 INFO - building 'psutil._psutil_linux' extension 17:47:24 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 17:47:24 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 17:47:24 INFO - building 'psutil._psutil_posix' extension 17:47:24 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 17:47:24 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 17:47:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:24 INFO - Successfully installed psutil 17:47:24 INFO - Cleaning up... 17:47:24 INFO - Return code: 0 17:47:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:47:24 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')]} 17:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:24 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')]} 17:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:24 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 0x7f60a0e58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140c160>, '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 0x140d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140d4f0>, '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': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', '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 17:47:24 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 17:47:24 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 17:47:24 INFO - Using env: {'DISPLAY': ':0', 17:47:24 INFO - 'HOME': '/home/cltbld', 17:47:24 INFO - 'LANG': 'en_US.UTF-8', 17:47:24 INFO - 'LANGUAGE': 'en_US:en', 17:47:24 INFO - 'LOGNAME': 'cltbld', 17:47:24 INFO - 'MAIL': '/var/mail/cltbld', 17:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:24 INFO - 'MOZ_NO_REMOTE': '1', 17:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:24 INFO - 'NO_EM_RESTART': '1', 17:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:24 INFO - 'PWD': '/builds/slave/test', 17:47:24 INFO - 'SHELL': '/bin/bash', 17:47:24 INFO - 'SHLVL': '1', 17:47:24 INFO - 'TERM': 'linux', 17:47:24 INFO - 'TMOUT': '86400', 17:47:24 INFO - 'USER': 'cltbld', 17:47:24 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', 17:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:24 INFO - '_': '/tools/buildbot/bin/python'} 17:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:47:24 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 17:47:24 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 17:47:24 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 17:47:24 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 17:47:24 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 17:47:24 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 17:47:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:47:26 INFO - Installing collected packages: mozsystemmonitor 17:47:26 INFO - Running setup.py install for mozsystemmonitor 17:47:26 INFO - Successfully installed mozsystemmonitor 17:47:26 INFO - Cleaning up... 17:47:27 INFO - Return code: 0 17:47:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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', '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 0x7f60a0e58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140c160>, '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 0x140d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140d4f0>, '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': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', '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 17:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:47: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 blobuploader==1.2.4 17:47:27 INFO - Using env: {'DISPLAY': ':0', 17:47:27 INFO - 'HOME': '/home/cltbld', 17:47:27 INFO - 'LANG': 'en_US.UTF-8', 17:47:27 INFO - 'LANGUAGE': 'en_US:en', 17:47:27 INFO - 'LOGNAME': 'cltbld', 17:47:27 INFO - 'MAIL': '/var/mail/cltbld', 17:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:27 INFO - 'MOZ_NO_REMOTE': '1', 17:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:27 INFO - 'NO_EM_RESTART': '1', 17:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:27 INFO - 'PWD': '/builds/slave/test', 17:47:27 INFO - 'SHELL': '/bin/bash', 17:47:27 INFO - 'SHLVL': '1', 17:47:27 INFO - 'TERM': 'linux', 17:47:27 INFO - 'TMOUT': '86400', 17:47:27 INFO - 'USER': 'cltbld', 17:47:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', 17:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:27 INFO - '_': '/tools/buildbot/bin/python'} 17:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:27 INFO - Downloading/unpacking blobuploader==1.2.4 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:29 INFO - Downloading blobuploader-1.2.4.tar.gz 17:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:47:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:47:29 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 17:47:29 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 17:47:29 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 17:47:29 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 17:47:29 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 17:47:29 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 17:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:47:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:47:29 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 17:47:29 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 17:47:29 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 17:47:29 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 17:47:29 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 17:47:29 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 17:47:29 INFO - Downloading docopt-0.6.1.tar.gz 17:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:47:29 INFO - Installing collected packages: blobuploader, requests, docopt 17:47:29 INFO - Running setup.py install for blobuploader 17:47:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:47:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:47:30 INFO - Running setup.py install for requests 17:47:30 INFO - Running setup.py install for docopt 17:47:30 INFO - Successfully installed blobuploader requests docopt 17:47:30 INFO - Cleaning up... 17:47:30 INFO - Return code: 0 17:47:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:30 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')]} 17:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:30 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')]} 17:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:30 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 0x7f60a0e58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140c160>, '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 0x140d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140d4f0>, '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': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', '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 17:47:30 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 17:47:30 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 17:47:30 INFO - Using env: {'DISPLAY': ':0', 17:47:30 INFO - 'HOME': '/home/cltbld', 17:47:30 INFO - 'LANG': 'en_US.UTF-8', 17:47:30 INFO - 'LANGUAGE': 'en_US:en', 17:47:30 INFO - 'LOGNAME': 'cltbld', 17:47:30 INFO - 'MAIL': '/var/mail/cltbld', 17:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:30 INFO - 'MOZ_NO_REMOTE': '1', 17:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:30 INFO - 'NO_EM_RESTART': '1', 17:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:30 INFO - 'PWD': '/builds/slave/test', 17:47:30 INFO - 'SHELL': '/bin/bash', 17:47:30 INFO - 'SHLVL': '1', 17:47:30 INFO - 'TERM': 'linux', 17:47:30 INFO - 'TMOUT': '86400', 17:47:30 INFO - 'USER': 'cltbld', 17:47:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', 17:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:30 INFO - '_': '/tools/buildbot/bin/python'} 17:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:30 INFO - Running setup.py (path:/tmp/pip-ZgBxYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:30 INFO - Running setup.py (path:/tmp/pip-g6qJUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:30 INFO - Running setup.py (path:/tmp/pip-1qDTcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:30 INFO - Running setup.py (path:/tmp/pip-CM8TDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:31 INFO - Running setup.py (path:/tmp/pip-66ouh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:31 INFO - Running setup.py (path:/tmp/pip-8sVMC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:31 INFO - Running setup.py (path:/tmp/pip-QnzP_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:31 INFO - Running setup.py (path:/tmp/pip-bWestj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:31 INFO - Running setup.py (path:/tmp/pip-tn0lXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:31 INFO - Running setup.py (path:/tmp/pip-cruFsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:31 INFO - Running setup.py (path:/tmp/pip-lZKvK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:31 INFO - Running setup.py (path:/tmp/pip-9htUya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:31 INFO - Running setup.py (path:/tmp/pip-t5raIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:31 INFO - Running setup.py (path:/tmp/pip-AECeqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:31 INFO - Running setup.py (path:/tmp/pip-Ioczrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:31 INFO - Running setup.py (path:/tmp/pip-v_LteN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:31 INFO - Running setup.py (path:/tmp/pip-2zcgZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:47:31 INFO - Running setup.py install for manifestparser 17:47:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:47:32 INFO - Running setup.py install for mozcrash 17:47:32 INFO - Running setup.py install for mozdebug 17:47:32 INFO - Running setup.py install for mozdevice 17:47:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:47:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:47:32 INFO - Running setup.py install for mozfile 17:47:32 INFO - Running setup.py install for mozhttpd 17:47:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:47:32 INFO - Running setup.py install for mozinfo 17:47:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:47:32 INFO - Running setup.py install for mozInstall 17:47:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:47:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:47:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:47:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:47:32 INFO - Running setup.py install for mozleak 17:47:32 INFO - Running setup.py install for mozlog 17:47:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:47:33 INFO - Running setup.py install for moznetwork 17:47:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:47:33 INFO - Running setup.py install for mozprocess 17:47:33 INFO - Running setup.py install for mozprofile 17:47:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:47:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:47:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:47:33 INFO - Running setup.py install for mozrunner 17:47:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:47:33 INFO - Running setup.py install for mozscreenshot 17:47:33 INFO - Running setup.py install for moztest 17:47:33 INFO - Running setup.py install for mozversion 17:47:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:47:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:47:33 INFO - Cleaning up... 17:47:33 INFO - Return code: 0 17:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:33 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 0x7f60a0e58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140c160>, '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 0x140d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140d4f0>, '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': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', '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 17:47:33 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 17:47:33 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 17:47:33 INFO - Using env: {'DISPLAY': ':0', 17:47:33 INFO - 'HOME': '/home/cltbld', 17:47:33 INFO - 'LANG': 'en_US.UTF-8', 17:47:33 INFO - 'LANGUAGE': 'en_US:en', 17:47:33 INFO - 'LOGNAME': 'cltbld', 17:47:33 INFO - 'MAIL': '/var/mail/cltbld', 17:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:33 INFO - 'MOZ_NO_REMOTE': '1', 17:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:33 INFO - 'NO_EM_RESTART': '1', 17:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:33 INFO - 'PWD': '/builds/slave/test', 17:47:33 INFO - 'SHELL': '/bin/bash', 17:47:33 INFO - 'SHLVL': '1', 17:47:33 INFO - 'TERM': 'linux', 17:47:33 INFO - 'TMOUT': '86400', 17:47:33 INFO - 'USER': 'cltbld', 17:47:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', 17:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:33 INFO - '_': '/tools/buildbot/bin/python'} 17:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:34 INFO - Running setup.py (path:/tmp/pip-18Z8a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:34 INFO - Running setup.py (path:/tmp/pip-8pJxu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:34 INFO - Running setup.py (path:/tmp/pip-GNANP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:34 INFO - Running setup.py (path:/tmp/pip-SmSEGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:34 INFO - Running setup.py (path:/tmp/pip-Aw3bYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:34 INFO - Running setup.py (path:/tmp/pip-evvXrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:34 INFO - Running setup.py (path:/tmp/pip-n0TdC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:34 INFO - Running setup.py (path:/tmp/pip-ESqbta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:34 INFO - Running setup.py (path:/tmp/pip-hpo4BY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:34 INFO - Running setup.py (path:/tmp/pip-AFWKkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:34 INFO - Running setup.py (path:/tmp/pip-Tn1gIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:34 INFO - Running setup.py (path:/tmp/pip-9Tl2az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:34 INFO - Running setup.py (path:/tmp/pip-vEwEHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:34 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)) 17:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:34 INFO - Running setup.py (path:/tmp/pip-dmtZlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:35 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)) 17:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:35 INFO - Running setup.py (path:/tmp/pip-rMnV3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:35 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)) 17:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:35 INFO - Running setup.py (path:/tmp/pip-oebPqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:35 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)) 17:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:35 INFO - Running setup.py (path:/tmp/pip-SSG8DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:47:35 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 17:47:35 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 17:47:35 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 17:47:35 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 17:47:35 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 17:47:35 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 17:47:37 INFO - Downloading blessings-1.6.tar.gz 17:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:47:37 INFO - Installing collected packages: blessings 17:47:37 INFO - Running setup.py install for blessings 17:47:37 INFO - Successfully installed blessings 17:47:37 INFO - Cleaning up... 17:47:37 INFO - Return code: 0 17:47:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:47:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:37 INFO - Reading from file tmpfile_stdout 17:47:37 INFO - Current package versions: 17:47:37 INFO - argparse == 1.2.1 17:47:37 INFO - blessings == 1.6 17:47:37 INFO - blobuploader == 1.2.4 17:47:37 INFO - docopt == 0.6.1 17:47:37 INFO - manifestparser == 1.1 17:47:37 INFO - mozInstall == 1.12 17:47:37 INFO - mozcrash == 0.17 17:47:37 INFO - mozdebug == 0.1 17:47:37 INFO - mozdevice == 0.48 17:47:37 INFO - mozfile == 1.2 17:47:37 INFO - mozhttpd == 0.7 17:47:37 INFO - mozinfo == 0.9 17:47:37 INFO - mozleak == 0.1 17:47:37 INFO - mozlog == 3.1 17:47:37 INFO - moznetwork == 0.27 17:47:37 INFO - mozprocess == 0.22 17:47:37 INFO - mozprofile == 0.28 17:47:37 INFO - mozrunner == 6.11 17:47:37 INFO - mozscreenshot == 0.1 17:47:37 INFO - mozsystemmonitor == 0.0 17:47:37 INFO - moztest == 0.7 17:47:37 INFO - mozversion == 1.4 17:47:37 INFO - psutil == 3.1.1 17:47:37 INFO - requests == 1.2.3 17:47:37 INFO - wsgiref == 0.1.2 17:47:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:37 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 0x7f60a0e58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140c160>, '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 0x140d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140d4f0>, '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': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', '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 17:47:37 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 17:47:37 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 17:47:37 INFO - Using env: {'DISPLAY': ':0', 17:47:37 INFO - 'HOME': '/home/cltbld', 17:47:37 INFO - 'LANG': 'en_US.UTF-8', 17:47:37 INFO - 'LANGUAGE': 'en_US:en', 17:47:37 INFO - 'LOGNAME': 'cltbld', 17:47:37 INFO - 'MAIL': '/var/mail/cltbld', 17:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:37 INFO - 'MOZ_NO_REMOTE': '1', 17:47:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:37 INFO - 'NO_EM_RESTART': '1', 17:47:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:37 INFO - 'PWD': '/builds/slave/test', 17:47:37 INFO - 'SHELL': '/bin/bash', 17:47:37 INFO - 'SHLVL': '1', 17:47:37 INFO - 'TERM': 'linux', 17:47:37 INFO - 'TMOUT': '86400', 17:47:37 INFO - 'USER': 'cltbld', 17:47:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', 17:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:37 INFO - '_': '/tools/buildbot/bin/python'} 17:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:37 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)) 17:47:37 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)) 17:47:37 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)) 17:47:37 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)) 17:47:37 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)) 17:47:37 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)) 17:47:37 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)) 17:47:37 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)) 17:47:37 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)) 17:47:37 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)) 17:47:37 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)) 17:47:37 INFO - Cleaning up... 17:47:37 INFO - Return code: 0 17:47:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:37 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 0x7f60a0e58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140c160>, '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 0x140d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140d4f0>, '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': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', '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 17:47:37 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 17:47:37 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 17:47:37 INFO - Using env: {'DISPLAY': ':0', 17:47:37 INFO - 'HOME': '/home/cltbld', 17:47:37 INFO - 'LANG': 'en_US.UTF-8', 17:47:37 INFO - 'LANGUAGE': 'en_US:en', 17:47:37 INFO - 'LOGNAME': 'cltbld', 17:47:37 INFO - 'MAIL': '/var/mail/cltbld', 17:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:37 INFO - 'MOZ_NO_REMOTE': '1', 17:47:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:37 INFO - 'NO_EM_RESTART': '1', 17:47:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:37 INFO - 'PWD': '/builds/slave/test', 17:47:37 INFO - 'SHELL': '/bin/bash', 17:47:37 INFO - 'SHLVL': '1', 17:47:37 INFO - 'TERM': 'linux', 17:47:37 INFO - 'TMOUT': '86400', 17:47:37 INFO - 'USER': 'cltbld', 17:47:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', 17:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:37 INFO - '_': '/tools/buildbot/bin/python'} 17:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:37 INFO - Downloading/unpacking jsonschema 17:47:37 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 17:47:37 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 17:47:37 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 17:47:37 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 17:47:37 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 17:47:37 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 17:47:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:47:39 INFO - Downloading/unpacking functools32 (from jsonschema) 17:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:40 INFO - Downloading functools32-3.2.3-2.tar.gz 17:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:47:40 INFO - warning: no files found matching '*.txt' 17:47:40 INFO - no previously-included directories found matching 'build' 17:47:40 INFO - no previously-included directories found matching 'dist' 17:47:40 INFO - no previously-included directories found matching '.git*' 17:47:40 INFO - Installing collected packages: jsonschema, functools32 17:47:40 INFO - Running setup.py install for functools32 17:47:40 INFO - warning: no files found matching '*.txt' 17:47:40 INFO - no previously-included directories found matching 'build' 17:47:40 INFO - no previously-included directories found matching 'dist' 17:47:40 INFO - no previously-included directories found matching '.git*' 17:47:40 INFO - Successfully installed jsonschema functools32 17:47:40 INFO - Cleaning up... 17:47:40 INFO - Return code: 0 17:47:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:40 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 0x7f60a0e58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137d410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140c160>, '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 0x140d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140d4f0>, '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': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', '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 17:47:40 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 17:47:40 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 17:47:40 INFO - Using env: {'DISPLAY': ':0', 17:47:40 INFO - 'HOME': '/home/cltbld', 17:47:40 INFO - 'LANG': 'en_US.UTF-8', 17:47:40 INFO - 'LANGUAGE': 'en_US:en', 17:47:40 INFO - 'LOGNAME': 'cltbld', 17:47:40 INFO - 'MAIL': '/var/mail/cltbld', 17:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:40 INFO - 'MOZ_NO_REMOTE': '1', 17:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:40 INFO - 'NO_EM_RESTART': '1', 17:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:40 INFO - 'PWD': '/builds/slave/test', 17:47:40 INFO - 'SHELL': '/bin/bash', 17:47:40 INFO - 'SHLVL': '1', 17:47:40 INFO - 'TERM': 'linux', 17:47:40 INFO - 'TMOUT': '86400', 17:47:40 INFO - 'USER': 'cltbld', 17:47:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', 17:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:40 INFO - '_': '/tools/buildbot/bin/python'} 17:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:40 INFO - Downloading/unpacking flake8 17:47:40 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 17:47:40 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 17:47:40 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 17:47:40 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 17:47:40 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 17:47:40 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 17:47:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:47:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:47:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:47:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:47:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:47:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:47:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:47:43 INFO - no previously-included directories found matching 'docs/_build' 17:47:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:47:43 INFO - Running setup.py install for pep8 17:47:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:47:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:47:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:47:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:47:43 INFO - no previously-included directories found matching 'docs/_build' 17:47:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:47:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:47:43 INFO - Cleaning up... 17:47:43 INFO - Return code: 0 17:47:43 INFO - Running post-action listener: _resource_record_post_action 17:47:43 INFO - Running post-action listener: _start_resource_monitoring 17:47:43 INFO - Starting resource monitoring. 17:47:43 INFO - ##### 17:47:43 INFO - ##### Running install step. 17:47:43 INFO - ##### 17:47:43 INFO - Running pre-action listener: _resource_record_pre_action 17:47:43 INFO - Running main action method: install 17:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:43 INFO - Reading from file tmpfile_stdout 17:47:43 INFO - Detecting whether we're running mozinstall >=1.0... 17:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:47:43 INFO - Reading from file tmpfile_stdout 17:47:43 INFO - Output received: 17:47:43 INFO - Usage: mozinstall [options] installer 17:47:43 INFO - Options: 17:47:43 INFO - -h, --help show this help message and exit 17:47:43 INFO - -d DEST, --destination=DEST 17:47:43 INFO - Directory to install application into. [default: 17:47:43 INFO - "/builds/slave/test"] 17:47:43 INFO - --app=APP Application being installed. [default: firefox] 17:47:43 INFO - mkdir: /builds/slave/test/build/application 17:47:43 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'] 17:47:43 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 17:47:59 INFO - Reading from file tmpfile_stdout 17:47:59 INFO - Output received: 17:47:59 INFO - /builds/slave/test/build/application/firefox/firefox 17:47:59 INFO - Running post-action listener: _resource_record_post_action 17:47:59 INFO - ##### 17:47:59 INFO - ##### Running run-tests step. 17:47:59 INFO - ##### 17:47:59 INFO - Running pre-action listener: _resource_record_pre_action 17:47:59 INFO - Running main action method: run_tests 17:47:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:47:59 INFO - Python 2.7.3 17:47:59 INFO - Return code: 0 17:47:59 INFO - grabbing minidump binary from tooltool 17:47:59 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')]} 17:47:59 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 0x140c160>, '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 0x140d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140d4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:47:59 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 17:47:59 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 17:47:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:47:59 INFO - Return code: 0 17:47:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:47:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:47:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:47:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:47:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:47:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:48:00 INFO - Return code: 0 17:48:00 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/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 17:48:00 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/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 17:48:00 INFO - Using env: {'DISPLAY': ':0', 17:48:00 INFO - 'HOME': '/home/cltbld', 17:48:00 INFO - 'LANG': 'en_US.UTF-8', 17:48:00 INFO - 'LANGUAGE': 'en_US:en', 17:48:00 INFO - 'LOGNAME': 'cltbld', 17:48:00 INFO - 'MAIL': '/var/mail/cltbld', 17:48:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:48:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:00 INFO - 'MOZ_NO_REMOTE': '1', 17:48:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:00 INFO - 'NO_EM_RESTART': '1', 17:48:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:00 INFO - 'PWD': '/builds/slave/test', 17:48:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:48:00 INFO - 'SHELL': '/bin/bash', 17:48:00 INFO - 'SHLVL': '1', 17:48:00 INFO - 'TERM': 'linux', 17:48:00 INFO - 'TMOUT': '86400', 17:48:00 INFO - 'USER': 'cltbld', 17:48:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035', 17:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:00 INFO - '_': '/tools/buildbot/bin/python'} 17:48:00 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/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 17:48:00 INFO - mozversion application_buildid: 20160316163410 17:48:00 INFO - mozversion application_changeset: 20218dd51efaa84dcb1f2e98f08e851a9bf299e3 17:48:00 INFO - mozversion application_display_name: Nightly 17:48:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:48:00 INFO - mozversion application_name: Firefox 17:48:00 INFO - mozversion application_remotingname: firefox 17:48:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:48:00 INFO - mozversion application_vendor: Mozilla 17:48:00 INFO - mozversion application_version: 48.0a1 17:48:00 INFO - mozversion platform_buildid: 20160316163410 17:48:00 INFO - mozversion platform_changeset: 20218dd51efaa84dcb1f2e98f08e851a9bf299e3 17:48:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:48:00 INFO - mozversion platform_version: 48.0a1 17:48:00 INFO - using testdate: 1458175680 17:48:00 INFO - actual date: 1458175680 17:48:00 INFO - starting webserver on 'localhost:54449' 17:48:00 INFO - SUITE-START | Running 2 tests 17:48:00 INFO - TEST-START | dromaeo_css 17:48:00 INFO - operating with platform_type : linux_ 17:48:00 INFO - Initialising browser for dromaeo_css test... 17:48:00 INFO - TEST-INFO | started process 14555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8xDL2q/profile http://localhost:54449/getInfo.html) 17:48:04 INFO - PROCESS | 14555 | __metrics Screen width/height:1600/1200 17:48:04 INFO - PROCESS | 14555 | colorDepth:24 17:48:04 INFO - PROCESS | 14555 | Browser inner width/height: 1024/697 17:48:04 INFO - PROCESS | 14555 | __metrics 17:48:05 ERROR - PROCESS | 14555 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:48:05 INFO - PROCESS | 14555 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:48:06 INFO - TEST-INFO | 14555: exit 0 17:48:06 INFO - Browser initialized. 17:48:06 INFO - Running cycle 1/1 for dromaeo_css test... 17:48:06 INFO - TEST-INFO | started process 14649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8xDL2q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:48:18 INFO - PROCESS | 14649 | RSS: Main: 154435584 17:48:18 INFO - PROCESS | 14649 | 17:49:09 INFO - PROCESS | 14649 | 1458175749941 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] 17:51:21 INFO - PROCESS | 14649 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54449/tests/dromaeo/cssquery-ext.html) 17:51:22 INFO - PROCESS | 14649 | RSS: Main: 251486208 17:51:22 INFO - PROCESS | 14649 | 17:54:24 INFO - PROCESS | 14649 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-ext.html (next: http://localhost:54449/tests/dromaeo/cssquery-jquery.html) 17:54:25 INFO - PROCESS | 14649 | RSS: Main: 242831360 17:54:25 INFO - PROCESS | 14649 | 17:57:27 INFO - PROCESS | 14649 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54449/tests/dromaeo/cssquery-mootools.html) 17:57:27 INFO - PROCESS | 14649 | RSS: Main: 241192960 17:57:27 INFO - PROCESS | 14649 | 18:00:29 INFO - PROCESS | 14649 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54449/tests/dromaeo/cssquery-prototype.html) 18:00:30 INFO - PROCESS | 14649 | RSS: Main: 206934016 18:00:30 INFO - PROCESS | 14649 | 18:03:32 INFO - PROCESS | 14649 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54449/tests/dromaeo/cssquery-yui.html) 18:03:33 INFO - PROCESS | 14649 | RSS: Main: 209096704 18:03:33 INFO - PROCESS | 14649 | 18:06:36 INFO - PROCESS | 14649 | Cycle 1(1): loaded http://localhost:54449/tests/dromaeo/cssquery-yui.html (next: http://localhost:54449/tests/dromaeo/cssquery-dojo.html) 18:06:36 INFO - PROCESS | 14649 | RSS: Main: 267694080 18:06:36 INFO - PROCESS | 14649 | 18:06:36 INFO - PROCESS | 14649 | __start_tp_report 18:06:36 INFO - PROCESS | 14649 | _x_x_mozilla_page_load 18:06:36 INFO - PROCESS | 14649 | _x_x_mozilla_page_load_details 18:06:36 INFO - PROCESS | 14649 | |i|pagename|runs| 18:06:36 INFO - PROCESS | 14649 | |0;dojo.html;2589.3526618345413;2675.9866200668994;2677.123038186324;2693.8922443102265;2717.6738791345037;4481.686281960264;4588.954110458894;4633.976830115845;4651.767411629417;4667.69659972102;4647.976760116195;4662.323963025359;4726.976365118178;4727.66906316558;4755.6908800928;4242;4252.192083504125;4281.6360609348085;4314.050908800059;4375.278079116958;4219.514755803076;4318.892027699301;4330.06903515744;4337.696361254713;4373.781310934456;4279.2725236709675;4285.46431696038;4326.653867690608;4354.608085272341;4364.323529852878;4310.978445107786;4312.698111132222;4319;4340.956590434118;4349.652027837797;4184.727992680497;4268.253055715269;4308.375285583604;4309.030468144674;4344.652427805768;4579.542045795427;4607.562281583244;4635.629149668019;4635.814567417333;4681.227597446417;4965.503449655042;4994.675346102528;4997.150484417622;5007.173816320303;5033.597312215014;4871.926921096151;4983.626228032876;5025.547700706918;5034.899302013976;5066.695998240118;4693.06138772247;4695.460022097503;4695.647826412965;4724.834630787906;4737.289406589005;5132.923006154911;5138.87152821175;5139.177731563007;5157.922631160535;5186.170212765939;4745.454272758608;4819.397575303087;4906.337644418029;4924.162892308316;4942.5304596063315;4943.629227807857;4955.702657840469;4963.528464795839;4967.875803104879;5024.547790698854;4940.7035577865445;4944.653874228841;4945.035718034948;4946.901061978812;4998.175301075282;4756.857294281177;4897.706137631682;4955.504449555087;4997.225430058346;5002.899942001212;4248.723832950848;4254.149170165979;4264.893377665583;4267.722598031118;4310.267254566731;3684.373656478405;3734.7572407793405;3758.4174452959833;3763.717721170923;3765;4307.440032795716;4346.826126954949;4348.456442944632;4388.5830846069575;4390.385346051556;4929.654924155275;4971.055499455092;4975.154223781966;4976.377952755905;5003.4746351633285;4181.163767246563;4266.424032755538;4278.101598664315;4279.3153095505195;4314.870553883388;4541.72749635023;4549.7497637629585;4550.704204226715;4588.88527786808;4593.448786145684;4742.881427964259;4767.499412561631;4768.499307572655;4770.045990801854;4812.302216178705;4875.536824001714;4942.75286235694;5025.095482813129;5032.094223039888;5043.5460808527405;4749.786259618257;4768.66619336657;4769.9046019080115;4795.9280610790165;4818.8795280118275;4948.752562371795;4952.306677065286;4953.380827396575;4960.826371076995;5014.272930424995;4905.313256144072;4955.207166853286;5022.472640372708;5022.623303252198;5053.29253904461;4859.562639362474;4862;4868.878278043077;4875.463698993037;4928.556429921181;4822.903541929212;4842.661013729146;4879.926801098058;4882.951170488392;4940.431850337257;4696.272077827942;4777.665563410528;4780.211265141213;4829.323894654822;4845.297431872429;4875.731834749123;4889.731064791471;4891.584215341593;4901.534354236342;4946.332245146859;4721.716696998191;4791.041791641616;4793.664443488922;4796.304535842353;4798.760061996956 18:06:36 INFO - PROCESS | 14649 | |1;ext.html;525.2488940814635;530.6842428754892;541.3666010767402;547.1628408534941;560.0535095688284;28886.566701499494;35352.64647353532;35464.46803297952;35610.287794244134;35788;37944;38439.23121537568;38476;38477.80761096197;38502.22995540088;7598.77203683889;7731.922680773177;7774.572398518079;7780.766577002699;7781.182975787546;7638.809029774272;7750.457467977244;7776.688932442696;7789.06531216252;7914.762557123267;7891.092524359686;7957;7958.681652733883;7962.5620590867475;7973.800654983643;7819.726309579166;7906.169852165497;7921.089074756362;7922.049354077548;7926.365890728728;7667.5782831944225;7773.572453515055;7789.376849852055;7791.4156438267355;7797.415193860483;37009;37544.81227593872;37596.62403375959;37674.43488347677;37740.245195095944;2809.4802461544477;2844;2889.0899366699423;2895.319599894044;3048.588440560518;28468.145955621363;29278.70721292781;29449.852750736325;29594.852025739732;30092;3246.642869284377;3256.739460843127;3260.559824423696;3346.5482159908343;3420.452727563603;244512;245929;246108;246199;246304.9999999982;52676.473235267156;53006;53030.469695302556;53074.469255307726;53118;67587;69627.65186174138;69709;69745.65127174332;69755;14400.567982960529;14454.349554270084;14549.709005819825;14550.27248637564;14566.41734330615;11677.299362038304;11701.941490292664;11768.88231117695;11772.941135294268;11776.764464710657;19405.51486212828;19515.60968780645;19649.90175049144;19739.605207895762;19752.209911603375;7851.685932562634;8013.398995075393;8028.598570071473;8111.351091912633;8149.8370032600205;918.2699753695828;928.3130483442204;936.1527817325332;968.4963818814177;1042.635077722791;25847.353816154748;27481.31296717598;27880.18778779373;27893;27914.16257512278;873.912608739121;969.340848223215;991.1129539062499;999.6201443451442;1001.5977631316216;12847.48610055606;12938;12946.158499697489;13079.280639564726;13110.737785244242;275109;277851;280047;280906;281271;46143.30785038227;46638.76680616575;46701.5329846704;46706.53293467022;46776.766116169885;1134.7957367673898;1226.5032661771997;1227.5396726227486;1239.4546399584153;1256.0893352319495;24243.878780605985;26118.216453506426;27002.729972700807;27051.188464345312;27084.593731094443;34989;35369.64630353663;35377.469337960465;35408.82295588506;35481.64518354784;167286;169285;170657;181025;183258;26831.195064148105;30784;31305.373892521566;31649.683503165594;31857.362852742353;35323.47014794831;36404.63595364012;36708.632913670524;36714.44928326024;36888.26223475462;31634.525482117326;32127.357452850345;32864;33170.50244246387;33325.16687082842;32592.674073258964;32644.34711305808;32704.83647581747;32771.83614081914;32917.17707057247;29833.25416864509;29958.850205748833;29971;30137.849310753307;32210.516842247853;28445.431091378472;29041.854790726757;29509.26226844346;29523.409531808815;29593.85203073971;23159.452460229026;23305.300840974796;23334.2999710009;23574.410639734146;23704.8814755932 18:06:36 INFO - PROCESS | 14649 | |2;jquery.html;346.1519277769465;347.65582073747;348.0862735319786;359.6942598791026;362.4599346973009;12052.276863388191;12497.500099996001;12884.871151288484;15123.848761512381;15131.31909064092;14736.6315842104;15205.163715995615;15227.162506062163;15272.84727152731;15489.612759681013;4838.782254798533;5014.648974571782;5017.749112544377;5018.397792264915;5035.874103147414;4814.590759785422;4908.116539022974;4979.626528010395;5004.62465315101;5016.423111342187;4954.455009948902;4967.577755890754;4970.602351811846;4973.477784832595;4987.426445958725;4944.876378090558;4949.455559888409;4956.578690811303;5009.373828271466;5175.120229560984;4988.925166122511;5023.874403139914;5029.446760856303;5039;5049.5455409013;11710.941445292805;11888.167828252026;14511.854881451156;17955.461336159937;18012.729809052875;1844.6495165918432;1854.443666899938;1878.614883948801;1888.225827410755;2370.9644355334685;8339;9009.144131307516;9294.90705092954;10889.401082940434;12831.037672174623;1799.9280028798833;1812.465322729798;1837.4028440756808;1881.868269221155;1929.1029671202818;55113.72443137799;55823;56501.71749141269;57509.13736294001;58773.706131469065;9983.400995940267;10120.089191972758;10135.7466063349;10238.33450825694;10250.743731406774;12901.935490322676;12999.09006369545;13027.544035958696;13033.869661303455;13045.673858153432;7092.645367731593;7130.215676275606;7172.462065345016;7271.89092163618;7275.454340924452;6781.491388145909;6829.3170682932305;6842.794716158523;6943.236244013155;6945.0971373721095;4156.418101465797;4156.586760501444;4349.108432771274;4352.847650332286;4356;1687.7637130801697;1798.7122060470263;1811.112554848115;1812.209197835319;1841.677706401401;806.5967016491754;834.2241715204797;839.6011894350257;895.7581453007651;933.85992101184;15187.620309492351;15413.306401211972;15570.9221453892;15737.134457604941;15743.291551880193;878.1438097854541;891.3270480786964;898.2679116520015;927.1238679447991;930.2279108340061;8823.250023748053;8910.287177025823;8914.910850891409;8959.148880856308;9100.681476148304;421523;431027;434138;435165;447253;61931;64388.35611643917;64803.675981620734;65028.67485662542;65050.67474662596;925.1997022575424;938.671464987249;938.8732521109699;952.476138124029;952.7332346942867;13695.589132326046;13972.441102355791;14094.718105638034;14133.858661413666;14301.713965720835;29571.704282956896;31399;31515.52726709147;31959.68040319567;32148.517772233903;41295.7935210322;44699;44801.77599111984;44966.550334496234;45473;7269.382102521345;7439.51643143194;7442.9255707442235;7463.141738700119;7641.426892982938;11126.61056863006;11138.27601205919;11173.385463799244;11190.944045280046;11192.496337664661;10143.391396515937;10284.228682848965;10387;10398.27212095146;10530.894691053298;9909;10113.5448904798;10122.898771012196;10185.592576296865;10310.587576496857;10313.690589282334;10388.42863642507;10448.791024179625;10471.10995565355;10624.52189651483;7578.393728501596;7626.771196864103;7698.961505192438;7791.571463569331;7792.88310675329;9691.12779849817;10260.076593106656;10419.895801041892;10430.217733669853;10530.684079477627 18:06:36 INFO - PROCESS | 14649 | |3;mootools.html;1242.173954320377;1400.8038874557565;1429.0354011042543;1567.1615685608201;1781.3943259291839;7210.60341681208;7360.5215660982;7380.151282602503;7387;7404.148522919866;7214.747483838067;7371.373433258166;7374.446916481272;7380.852382952337;7383.778486645409;1897.7058555923784;1943.9125239364262;2164.8809315487642;2185.8142057925056;2215.667649852519;2236.329101269621;2253.5943530164564;2255.3684968208927;2256.0524579676576;2256.244158207003;2137.2519618133683;2165.339571430713;2177.6515757478805;2214.6235140026156;2220.0786673530465;2147.7207962964712;2167.9241226557074;2180.3894909425308;2183.2795177591356;2184.344696591016;2171.392010237136;2203.5923354179527;2208.1498623030247;2208.8122509586706;2211.0271480548668;7245.4928155029165;7298.306660867209;7308.976743255948;7315.926840731578;7320.1215854097845;4475.932861007088;4588.655850811169;4611.815527378901;4612.7924243409125;4613.746243956581;2887.422515496888;2919.7368485991205;3017.321102751885;3061.938761224763;3066.3100802319523;945.9668911588061;962.8459446488528;973.732223638505;998.9500524973795;1018.2312354172626;10329.483525823678;10344.741381465448;10347.120494757955;10357.274990750651;10358.482075896174;4139.317012692872;4233.491980962304;4255.914881702349;4316.956830431718;4332.068605249887;8886.289096872364;8910.153535414125;8912.55437228136;8924.55377231136;8953.686620968236;4520.276755719135;4530.478994915561;4545.2954792007295;4548.363229147922;4555.476120246214;3640.8543658253902;3712.1462063724953;4019.794061781454;4093.2427500912427;4142.792860357031;3476.3568739783223;3523.4010218262956;3580.2660454606744;3592.3354179476883;3611.6930060945115;1146.4611632532697;1178.8290697848936;1185.359905650956;1190.9047276217882;1196.7606478704295;923.5520772425368;961.8557216417454;1157.9478923448296;1172.4841069929205;1183.8638556566104;6764.5603035802515;6791.660416979132;6797.490188235902;6831.11195544586;6837.076994605764;1051.9684409467727;1062.436908438529;1069.4064794039382;1070.1011150633506;1087.7389426537575;5024.422191447957;5034.546890779848;5069.645124841226;5075.8984820303385;5075.97462012695;8832.955835220782;9087.681931132378;9109.863352049724;9306.627734890528;9306.813863722688;9092.454452732858;9113.863292050624;9164.908350916405;9213.12475314844;9223.169914707709;7126.465515086389;7193.532420392762;7281.56310621375;7313.378362839218;7317.780466586011;6673.833154171185;6691.966540167463;6714;6715.731370745116;6756.223034350916;8142.796430089295;8205.097439281555;8269.95865020671;8377.246047855722;8386.329093672613;8210.548419836967;8474.067852536093;8538.060813310407;8635;8680.348973826862;6068.271807382966;6154.78458253959;6219;6246.937530624818;6271.278802937721;7105.893411598727;7162.570245785269;7183.461240407095;7202.603856787927;7205.171405288459;6292.2449306081735;6361.427471527585;6367.522435817425;6537.70580323877;6639.269680335063;6275.058741188858;6320.399562041599;6357.523185760994;6415.390537898892;6423.678816059271;6684.197896252481;6697.162854643169;6711.3288671132495;6722.563033402813;6740.595564265964;6066.939330606638;6081.969590152021;6132.049532322497;6132.049532322497;6154.692265386802;6173.969130154321;6189.721462534107;6204.224471941007;6216.533759968111;6231.813045608639 18:06:36 INFO - PROCESS | 14649 | |4;prototype.html;311.59648255509114;326.3994250578935;328.52200048928813;328.59254524389746;329.39391519603925;5351.57187425006;5435.891282174359;5437.782488700457;5443.8094666686675;5444.455554444554;5321.388040375358;5364.651297665649;5369.006733754249;5373.785048598052;5387.676739395629;4022.3162062449305;4103.117829666621;4174.269502837006;4214.6417554507825;4224.239636865378;4183.435236243099;4210.62104410603;4222.809973551198;4229.725067870579;4243;4177.540470548237;4185.28850095483;4187.706860519765;4195.8741237762915;4199.727017743852;3983.3228351180223;4075.144219713849;4161.9375709364385;4164.7709375984305;4199.580041995807;3698.056995466166;3707.7404581679293;3709.7959612221316;3710.9814450927843;3717.851285948586;5140.665856719302;5151.974240128813;5157;5162.174052151638;5165.605286572604;4840.830570930036;4842.927356089662;4843.709377437365;4848;4850.854474365775;5646.40712725162;5647.898659761348;5650.576206784508;5650.830475085713;5658.321001479849;4083.5503396294184;4089.5705950875326;4090.325096359097;4092.242935057024;4097.467329247209;5764.596478246524;6018.578699491038;6019.518438524951;6024.126501657279;6030.638161710312;4011.3180759270995;4069.7965101745385;4070.5929407059057;4073.470448841691;4074.511058672919;4128.174365126986;4129.628333450004;4133.2146892091005;4133.318002529549;4136.896577585524;4732.810687572459;4738.976305118453;4740.976295118502;4749.382580264612;4755.286706993909;5709.286339207599;5716.714164291769;5717.171010203498;5719.513841323451;5729.083346664514;1482.6460754656807;1494.4993427201791;1517.1883042572172;1518.8025556677562;1519.4302136698739;941.5480569326761;1002.6490728245055;1038.1798379280435;1054.5360041581832;1058.576569372242;4904.313396124546;4912.680675756064;4913.31213630092;4917.213245880642;4937.1113199624415;5843;5848.707564621752;5854.326752423441;5855.092460668518;5858.443447872445;4958.950410495849;4960.181570040902;4970.105381031377;4971.527704868032;4972.7513624318635;3092.9536056959164;3121.360121175154;3121.5005599104034;3123.515855042472;3126.4685003549453;5486.670799752028;5499.862503437366;5516.9448305517235;5518.227448157181;5521.4478552144465;5913.526917846562;6140.969295153495;6145.10895920098;6147.415995480422;6148.262208535004;5590.972045139748;5622.240997465372;5626.437356264504;5629.971850140723;5631.887362252732;5963.373845746308;5978.491828194652;5979.581429300081;5980.312264089512;5982.4316689914385;5852.268466441695;5858.794942177004;5861.443162899518;5867.559933005127;5870.148828419769;5386.13821788512;5615.2700148980375;5616.494515493625;5618.129189975561;5621.072523033654;4010.7794071326357;4068.3083875740604;4085.5301640310554;4090.611391917763;4092.1815636872147;5917;5926.851828704317;5931.1399847021075;5931.5847890648965;5938.406159384027;5698.914516282176;5715.199872018004;5722.484976352148;5731.398203188605;5738.110592858114;5683.460071293221;5702.34423041339;5711.571632127524;5726.885462290814;5729.828105156852;5405.108157154025;5585.5531557476115;5603.159526071122;5617.382087970402;5629.043062679436;5707.08686610157;5716.114002329646;5775.364709881826;5788.450097240755;5798.391168927202;5668.489835914787;5672.262605861211;5679.119736440858;5679.659220446786;5680.204771331934 18:06:36 INFO - PROCESS | 14649 | |5;yui.html;608.7960533221368;626.2578844069781;671.0906721392513;703.6516924122559;726.7674344209852;11474.082073434127;11593.304401735903;11634.709132271677;11647.475863586127;11656.41717914104;11705.648830535098;11715.062794976402;11743.941280293586;11754.118441116907;11755.941220293907;627.9811605651815;766.9616519174047;776.0493395590413;777.1334961517895;798.3852433626133;788.6569342336102;791.3036527855479;794.3724457678427;794.7297918707638;794.8171920458298;837.6691206973272;838.8573942429801;840.1388576708861;841.3941961787503;842.616609442702;660.2802944790178;823.3125340340792;829.1087081387502;837.5812093953024;838.446625227347;615.6183166436838;615.8737458820931;616.0082267549242;616.6392660293734;616.7502161624549;11825.526978920832;11987.88012119885;11998.400079996052;12003.219790713576;12009.219400739012;11571.594994175164;12074.758504829853;12187.756244875052;12303.32331721755;12476.313802740846;9472;9628.951855240679;9872.1608663263;10051.447170405625;10072.94963525185;3339.1652086978256;3367.3938691035605;3382.780119292238;3400.387930172568;3484.564429446319;41806.79096604497;41876.37185442221;42028.15943681109;42054.1589168218;42134;9677.661281855102;9894.80210395788;9987.700368988943;10038.247131465023;10251.487425628839;17321.65356692859;17329.7400538992;17453.21460534279;17462.126893655266;17557.385491507735;6659.966700166468;6661.3005634408655;6740.494462915203;6741.966290168518;6934.965325173443;3675.3751862183494;3689.335919534456;3713.851445942132;3755.8685446009804;3801.828917698655;2793.273748825279;2804.8737806798745;2808.536591462386;2816.7464928156564;2837.815541989764;522.9372475302988;525.136151031551;528.3791544934686;537.4007981101045;540.8674874655735;410.6406893967778;450.916580432621;459.48996613758703;529.4573062610855;551.4402881075712;6705.463562914955;7599.65801538921;7686.769396918102;7720.15078341382;7922.603869806487;434.97825108744433;477.6369958831313;486.637296635663;525.1807180797967;527.1565495207637;3383.6278009418943;3491.5984661763714;3497.6852083312624;3497.89506314811;3634.818259087035;49318.013639727;49427;49581.25628115581;49721;49797.75101124471;41555;41891.581084188765;41918;41977;42757.78621106874;39310;41126;41214.38178427326;42396.152076958286;45139.54860451353;7864.606769661608;7875.409344299315;7904.881426778488;8028.558429286445;8214.671413143407;31667.20831979219;32047.198820029687;32995.505067424485;33046.504302435;33159.33681326408;40096;41677.1664566713;41717.16565668609;41780.16439671129;42265.78867105645;9815.067568580973;9819.312648114563;9930.304878658424;9988.45351424483;10103.696889093339;10099.192064634959;10231.693049208536;10297.897021029694;10333.121684656588;10543.209259305737;10645.361278323326;10840.132789376674;10870.891291086988;10888.61889833852;10931.344119352865;10705.456274988865;10926.781464370828;11044.447777611247;11099;11285.025504856521;9867.309288350034;10078.344907580984;10118.291719579558;10244.795104097728;10301.74245643865;8296.294814940798;8551.444156129832;8712.695055673275;8727.389082764146;8851.424657397249;8414.284785793276;8668.696595619123;8811.118888111137;9143.497107659143;9307.11582399671 18:06:36 INFO - PROCESS | 14649 | __end_tp_report 18:06:36 INFO - PROCESS | 14649 | __start_cc_report 18:06:36 INFO - PROCESS | 14649 | _x_x_mozilla_cycle_collect,845 18:06:36 INFO - PROCESS | 14649 | __end_cc_report 18:06:36 INFO - PROCESS | 14649 | __startTimestamp1458176796438__endTimestamp 18:06:36 INFO - PROCESS | 14649 | 18:06:36 INFO - PROCESS | 14649 | ------- Summary: start ------- 18:06:36 INFO - PROCESS | 14649 | Number of tests: 6 18:06:36 INFO - PROCESS | 14649 | 18:06:36 INFO - PROCESS | 14649 | [#0] dojo.html Cycles:165 Average:4624.29 Median:4768.50 stddev:469.77 (9.9%) stddev-sans-first:443.26 18:06:36 INFO - PROCESS | 14649 | Values: 2589.4 2676.0 2677.1 2693.9 2717.7 4481.7 4589.0 4634.0 4651.8 4667.7 4648.0 4662.3 4727.0 4727.7 4755.7 4242.0 4252.2 4281.6 4314.1 4375.3 4219.5 4318.9 4330.1 4337.7 4373.8 4279.3 4285.5 4326.7 4354.6 4364.3 4311.0 4312.7 4319.0 4341.0 4349.7 4184.7 4268.3 4308.4 4309.0 4344.7 4579.5 4607.6 4635.6 4635.8 4681.2 4965.5 4994.7 4997.2 5007.2 5033.6 4871.9 4983.6 5025.5 5034.9 5066.7 4693.1 4695.5 4695.6 4724.8 4737.3 5132.9 5138.9 5139.2 5157.9 5186.2 4745.5 4819.4 4906.3 4924.2 4942.5 4943.6 4955.7 4963.5 4967.9 5024.5 4940.7 4944.7 4945.0 4946.9 4998.2 4756.9 4897.7 4955.5 4997.2 5002.9 4248.7 4254.1 4264.9 4267.7 4310.3 3684.4 3734.8 3758.4 3763.7 3765.0 4307.4 4346.8 4348.5 4388.6 4390.4 4929.7 4971.1 4975.2 4976.4 5003.5 4181.2 4266.4 4278.1 4279.3 4314.9 4541.7 4549.7 4550.7 4588.9 4593.4 4742.9 4767.5 4768.5 4770.0 4812.3 4875.5 4942.8 5025.1 5032.1 5043.5 4749.8 4768.7 4769.9 4795.9 4818.9 4948.8 4952.3 4953.4 4960.8 5014.3 4905.3 4955.2 5022.5 5022.6 5053.3 4859.6 4862.0 4868.9 4875.5 4928.6 4822.9 4842.7 4879.9 4883.0 4940.4 4696.3 4777.7 4780.2 4829.3 4845.3 4875.7 4889.7 4891.6 4901.5 4946.3 4721.7 4791.0 4793.7 4796.3 4798.8 18:06:36 INFO - PROCESS | 14649 | 18:06:36 INFO - PROCESS | 14649 | [#1] ext.html Cycles:180 Average:39658.28 Median:32738.34 stddev:61975.09 (189.3%) stddev-sans-first:62079.29 18:06:36 INFO - PROCESS | 14649 | Values: 525.2 530.7 541.4 547.2 560.1 28886.6 35352.6 35464.5 35610.3 35788.0 37944.0 38439.2 38476.0 38477.8 38502.2 7598.8 7731.9 7774.6 7780.8 7781.2 7638.8 7750.5 7776.7 7789.1 7914.8 7891.1 7957.0 7958.7 7962.6 7973.8 7819.7 7906.2 7921.1 7922.0 7926.4 7667.6 7773.6 7789.4 7791.4 7797.4 37009.0 37544.8 37596.6 37674.4 37740.2 2809.5 2844.0 2889.1 2895.3 3048.6 28468.1 29278.7 29449.9 29594.9 30092.0 3246.6 3256.7 3260.6 3346.5 3420.5 244512.0 245929.0 246108.0 246199.0 246305.0 52676.5 53006.0 53030.5 53074.5 53118.0 67587.0 69627.7 69709.0 69745.7 69755.0 14400.6 14454.3 14549.7 14550.3 14566.4 11677.3 11701.9 11768.9 11772.9 11776.8 19405.5 19515.6 19649.9 19739.6 19752.2 7851.7 8013.4 8028.6 8111.4 8149.8 918.3 928.3 936.2 968.5 1042.6 25847.4 27481.3 27880.2 27893.0 27914.2 873.9 969.3 991.1 999.6 1001.6 12847.5 12938.0 12946.2 13079.3 13110.7 275109.0 277851.0 280047.0 280906.0 281271.0 46143.3 46638.8 46701.5 46706.5 46776.8 1134.8 1226.5 1227.5 1239.5 1256.1 24243.9 26118.2 27002.7 27051.2 27084.6 34989.0 35369.6 35377.5 35408.8 35481.6 167286.0 169285.0 170657.0 181025.0 183258.0 26831.2 30784.0 31305.4 31649.7 31857.4 35323.5 36404.6 36708.6 36714.4 36888.3 31634.5 32127.4 32864.0 33170.5 33325.2 32592.7 32644.3 32704.8 32771.8 32917.2 29833.3 29958.9 29971.0 30137.8 32210.5 28445.4 29041.9 29509.3 29523.4 29593.9 23159.5 23305.3 23334.3 23574.4 23704.9 18:06:36 INFO - PROCESS | 14649 | 18:06:36 INFO - PROCESS | 14649 | [#2] jquery.html Cycles:180 Average:24030.17 Median:219757.05 stddev:70952.87 (32.3%) stddev-sans-first:71129.62 18:06:36 INFO - PROCESS | 14649 | Values: 346.2 347.7 348.1 359.7 362.5 12052.3 12497.5 12884.9 15123.8 15131.3 14736.6 15205.2 15227.2 15272.8 15489.6 4838.8 5014.6 5017.7 5018.4 5035.9 4814.6 4908.1 4979.6 5004.6 5016.4 4954.5 4967.6 4970.6 4973.5 4987.4 4944.9 4949.5 4956.6 5009.4 5175.1 4988.9 5023.9 5029.4 5039.0 5049.5 11710.9 11888.2 14511.9 17955.5 18012.7 1844.6 1854.4 1878.6 1888.2 2371.0 8339.0 9009.1 9294.9 10889.4 12831.0 1799.9 1812.5 1837.4 1881.9 1929.1 55113.7 55823.0 56501.7 57509.1 58773.7 9983.4 10120.1 10135.7 10238.3 10250.7 12901.9 12999.1 13027.5 13033.9 13045.7 7092.6 7130.2 7172.5 7271.9 7275.5 6781.5 6829.3 6842.8 6943.2 6945.1 4156.4 4156.6 4349.1 4352.8 4356.0 1687.8 1798.7 1811.1 1812.2 1841.7 806.6 834.2 839.6 895.8 933.9 15187.6 15413.3 15570.9 15737.1 15743.3 878.1 891.3 898.3 927.1 930.2 8823.3 8910.3 8914.9 8959.1 9100.7 421523.0 431027.0 434138.0 435165.0 447253.0 61931.0 64388.4 64803.7 65028.7 65050.7 925.2 938.7 938.9 952.5 952.7 13695.6 13972.4 14094.7 14133.9 14301.7 29571.7 31399.0 31515.5 31959.7 32148.5 41295.8 44699.0 44801.8 44966.6 45473.0 7269.4 7439.5 7442.9 7463.1 7641.4 11126.6 11138.3 11173.4 11190.9 11192.5 10143.4 10284.2 10387.0 10398.3 10530.9 9909.0 10113.5 10122.9 10185.6 10310.6 10313.7 10388.4 10448.8 10471.1 10624.5 7578.4 7626.8 7699.0 7791.6 7792.9 9691.1 10260.1 10419.9 10430.2 10530.7 18:06:36 INFO - PROCESS | 14649 | 18:06:36 INFO - PROCESS | 14649 | [#3] mootools.html Cycles:180 Average:5218.45 Median:6164.38 stddev:2721.05 (44.1%) stddev-sans-first:2712.26 18:06:36 INFO - PROCESS | 14649 | Values: 1242.2 1400.8 1429.0 1567.2 1781.4 7210.6 7360.5 7380.2 7387.0 7404.1 7214.7 7371.4 7374.4 7380.9 7383.8 1897.7 1943.9 2164.9 2185.8 2215.7 2236.3 2253.6 2255.4 2256.1 2256.2 2137.3 2165.3 2177.7 2214.6 2220.1 2147.7 2167.9 2180.4 2183.3 2184.3 2171.4 2203.6 2208.1 2208.8 2211.0 7245.5 7298.3 7309.0 7315.9 7320.1 4475.9 4588.7 4611.8 4612.8 4613.7 2887.4 2919.7 3017.3 3061.9 3066.3 946.0 962.8 973.7 999.0 1018.2 10329.5 10344.7 10347.1 10357.3 10358.5 4139.3 4233.5 4255.9 4317.0 4332.1 8886.3 8910.2 8912.6 8924.6 8953.7 4520.3 4530.5 4545.3 4548.4 4555.5 3640.9 3712.1 4019.8 4093.2 4142.8 3476.4 3523.4 3580.3 3592.3 3611.7 1146.5 1178.8 1185.4 1190.9 1196.8 923.6 961.9 1157.9 1172.5 1183.9 6764.6 6791.7 6797.5 6831.1 6837.1 1052.0 1062.4 1069.4 1070.1 1087.7 5024.4 5034.5 5069.6 5075.9 5076.0 8833.0 9087.7 9109.9 9306.6 9306.8 9092.5 9113.9 9164.9 9213.1 9223.2 7126.5 7193.5 7281.6 7313.4 7317.8 6673.8 6692.0 6714.0 6715.7 6756.2 8142.8 8205.1 8270.0 8377.2 8386.3 8210.5 8474.1 8538.1 8635.0 8680.3 6068.3 6154.8 6219.0 6246.9 6271.3 7105.9 7162.6 7183.5 7202.6 7205.2 6292.2 6361.4 6367.5 6537.7 6639.3 6275.1 6320.4 6357.5 6415.4 6423.7 6684.2 6697.2 6711.3 6722.6 6740.6 6066.9 6082.0 6132.0 6132.0 6154.7 6174.0 6189.7 6204.2 6216.5 6231.8 18:06:36 INFO - PROCESS | 14649 | 18:06:36 INFO - PROCESS | 14649 | [#4] prototype.html Cycles:180 Average:4730.76 Median:5358.11 stddev:1386.58 (25.9%) stddev-sans-first:1350.22 18:06:36 INFO - PROCESS | 14649 | Values: 311.6 326.4 328.5 328.6 329.4 5351.6 5435.9 5437.8 5443.8 5444.5 5321.4 5364.7 5369.0 5373.8 5387.7 4022.3 4103.1 4174.3 4214.6 4224.2 4183.4 4210.6 4222.8 4229.7 4243.0 4177.5 4185.3 4187.7 4195.9 4199.7 3983.3 4075.1 4161.9 4164.8 4199.6 3698.1 3707.7 3709.8 3711.0 3717.9 5140.7 5152.0 5157.0 5162.2 5165.6 4840.8 4842.9 4843.7 4848.0 4850.9 5646.4 5647.9 5650.6 5650.8 5658.3 4083.6 4089.6 4090.3 4092.2 4097.5 5764.6 6018.6 6019.5 6024.1 6030.6 4011.3 4069.8 4070.6 4073.5 4074.5 4128.2 4129.6 4133.2 4133.3 4136.9 4732.8 4739.0 4741.0 4749.4 4755.3 5709.3 5716.7 5717.2 5719.5 5729.1 1482.6 1494.5 1517.2 1518.8 1519.4 941.5 1002.6 1038.2 1054.5 1058.6 4904.3 4912.7 4913.3 4917.2 4937.1 5843.0 5848.7 5854.3 5855.1 5858.4 4959.0 4960.2 4970.1 4971.5 4972.8 3093.0 3121.4 3121.5 3123.5 3126.5 5486.7 5499.9 5516.9 5518.2 5521.4 5913.5 6141.0 6145.1 6147.4 6148.3 5591.0 5622.2 5626.4 5630.0 5631.9 5963.4 5978.5 5979.6 5980.3 5982.4 5852.3 5858.8 5861.4 5867.6 5870.1 5386.1 5615.3 5616.5 5618.1 5621.1 4010.8 4068.3 4085.5 4090.6 4092.2 5917.0 5926.9 5931.1 5931.6 5938.4 5698.9 5715.2 5722.5 5731.4 5738.1 5683.5 5702.3 5711.6 5726.9 5729.8 5405.1 5585.6 5603.2 5617.4 5629.0 5707.1 5716.1 5775.4 5788.5 5798.4 5668.5 5672.3 5679.1 5679.7 5680.2 18:06:36 INFO - PROCESS | 14649 | 18:06:36 INFO - PROCESS | 14649 | [#5] yui.html Cycles:180 Average:12374.61 Median:42199.89 stddev:13972.30 (33.1%) stddev-sans-first:13983.56 18:06:36 INFO - PROCESS | 14649 | Values: 608.8 626.3 671.1 703.7 726.8 11474.1 11593.3 11634.7 11647.5 11656.4 11705.6 11715.1 11743.9 11754.1 11755.9 628.0 767.0 776.0 777.1 798.4 788.7 791.3 794.4 794.7 794.8 837.7 838.9 840.1 841.4 842.6 660.3 823.3 829.1 837.6 838.4 615.6 615.9 616.0 616.6 616.8 11825.5 11987.9 11998.4 12003.2 12009.2 11571.6 12074.8 12187.8 12303.3 12476.3 9472.0 9629.0 9872.2 10051.4 10072.9 3339.2 3367.4 3382.8 3400.4 3484.6 41806.8 41876.4 42028.2 42054.2 42134.0 9677.7 9894.8 9987.7 10038.2 10251.5 17321.7 17329.7 17453.2 17462.1 17557.4 6660.0 6661.3 6740.5 6742.0 6935.0 3675.4 3689.3 3713.9 3755.9 3801.8 2793.3 2804.9 2808.5 2816.7 2837.8 522.9 525.1 528.4 537.4 540.9 410.6 450.9 459.5 529.5 551.4 6705.5 7599.7 7686.8 7720.2 7922.6 435.0 477.6 486.6 525.2 527.2 3383.6 3491.6 3497.7 3497.9 3634.8 49318.0 49427.0 49581.3 49721.0 49797.8 41555.0 41891.6 41918.0 41977.0 42757.8 39310.0 41126.0 41214.4 42396.2 45139.5 7864.6 7875.4 7904.9 8028.6 8214.7 31667.2 32047.2 32995.5 33046.5 33159.3 40096.0 41677.2 41717.2 41780.2 42265.8 9815.1 9819.3 9930.3 9988.5 10103.7 10099.2 10231.7 10297.9 10333.1 10543.2 10645.4 10840.1 10870.9 10888.6 10931.3 10705.5 10926.8 11044.4 11099.0 11285.0 9867.3 10078.3 10118.3 10244.8 10301.7 8296.3 8551.4 8712.7 8727.4 8851.4 8414.3 8668.7 8811.1 9143.5 9307.1 18:06:36 INFO - PROCESS | 14649 | -------- Summary: end -------- 18:06:36 INFO - PROCESS | 14649 | 18:06:37 INFO - TEST-INFO | 14649: exit 0 18:06:37 INFO - TEST-OK | dromaeo_css | took 1116622ms 18:06:37 INFO - TEST-START | kraken 18:06:37 INFO - operating with platform_type : linux_ 18:06:37 INFO - Initialising browser for kraken test... 18:06:37 INFO - TEST-INFO | started process 14825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprsNvgw/profile http://localhost:54449/getInfo.html) 18:06:41 INFO - PROCESS | 14825 | __metrics Screen width/height:1600/1200 18:06:41 INFO - PROCESS | 14825 | colorDepth:24 18:06:41 INFO - PROCESS | 14825 | Browser inner width/height: 1024/697 18:06:41 INFO - PROCESS | 14825 | __metrics 18:06:42 ERROR - PROCESS | 14825 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:06:43 INFO - TEST-INFO | 14825: exit 0 18:06:43 INFO - Browser initialized. 18:06:43 INFO - Running cycle 1/1 for kraken test... 18:06:43 INFO - TEST-INFO | started process 14906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprsNvgw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:54 INFO - PROCESS | 14906 | RSS: Main: 154472448 18:06:54 INFO - PROCESS | 14906 | 18:06:57 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54449/tests/kraken/driver.html?testName=audio-beat-detection) 18:06:58 INFO - PROCESS | 14906 | RSS: Main: 195379200 18:06:58 INFO - PROCESS | 14906 | 18:07:00 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54449/tests/kraken/driver.html?testName=audio-dft) 18:07:01 INFO - PROCESS | 14906 | RSS: Main: 186077184 18:07:01 INFO - PROCESS | 14906 | 18:07:04 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54449/tests/kraken/driver.html?testName=audio-fft) 18:07:05 INFO - PROCESS | 14906 | RSS: Main: 170737664 18:07:05 INFO - PROCESS | 14906 | 18:07:07 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54449/tests/kraken/driver.html?testName=audio-oscillator) 18:07:07 INFO - PROCESS | 14906 | RSS: Main: 173744128 18:07:07 INFO - PROCESS | 14906 | 18:07:09 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54449/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:07:10 INFO - PROCESS | 14906 | RSS: Main: 175017984 18:07:10 INFO - PROCESS | 14906 | 18:07:13 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54449/tests/kraken/driver.html?testName=imaging-darkroom) 18:07:14 INFO - PROCESS | 14906 | RSS: Main: 174682112 18:07:14 INFO - PROCESS | 14906 | 18:07:17 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54449/tests/kraken/driver.html?testName=imaging-desaturate) 18:07:18 INFO - PROCESS | 14906 | RSS: Main: 175517696 18:07:18 INFO - PROCESS | 14906 | 18:07:21 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54449/tests/kraken/driver.html?testName=json-parse-financial) 18:07:21 INFO - PROCESS | 14906 | RSS: Main: 175050752 18:07:21 INFO - PROCESS | 14906 | 18:07:23 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54449/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:07:23 INFO - PROCESS | 14906 | RSS: Main: 184868864 18:07:23 INFO - PROCESS | 14906 | 18:07:25 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:07:26 INFO - PROCESS | 14906 | RSS: Main: 182018048 18:07:26 INFO - PROCESS | 14906 | 18:07:28 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:07:29 INFO - PROCESS | 14906 | RSS: Main: 189054976 18:07:29 INFO - PROCESS | 14906 | 18:07:31 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:07:32 INFO - PROCESS | 14906 | RSS: Main: 194609152 18:07:32 INFO - PROCESS | 14906 | 18:07:34 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:07:35 INFO - PROCESS | 14906 | RSS: Main: 193486848 18:07:35 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | Cycle 1(1): loaded http://localhost:54449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54449/tests/kraken/driver.html?testName=ai-astar) 18:07:37 INFO - PROCESS | 14906 | RSS: Main: 254849024 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | __start_tp_report 18:07:37 INFO - PROCESS | 14906 | _x_x_mozilla_page_load 18:07:37 INFO - PROCESS | 14906 | _x_x_mozilla_page_load_details 18:07:37 INFO - PROCESS | 14906 | |i|pagename|runs| 18:07:37 INFO - PROCESS | 14906 | |0;ai-astar;113;114;107;115;115;113;103;113;113;112 18:07:37 INFO - PROCESS | 14906 | |1;audio-beat-detection;155;131;157;181;131;153;156;129;178;131 18:07:37 INFO - PROCESS | 14906 | |2;audio-dft;161;162;159;160;161;161;165;160;161;161 18:07:37 INFO - PROCESS | 14906 | |3;audio-fft;74;73;99;95;74;74;78;109;92;72 18:07:37 INFO - PROCESS | 14906 | |4;audio-oscillator;95;95;146;93;94;94;138;95;95;139 18:07:37 INFO - PROCESS | 14906 | |5;imaging-gaussian-blur;117;118;116;117;117;117;117;117;116;117 18:07:37 INFO - PROCESS | 14906 | |6;imaging-darkroom;147;147;147;147;147;147;146;146;146;146 18:07:37 INFO - PROCESS | 14906 | |7;imaging-desaturate;96;97;95;96;96;95;96;96;96;95 18:07:37 INFO - PROCESS | 14906 | |8;json-parse-financial;64;64;66;66;65;66;65;74;64;63 18:07:37 INFO - PROCESS | 14906 | |9;json-stringify-tinderbox;64;64;64;64;65;65;64;65;65;66 18:07:37 INFO - PROCESS | 14906 | |10;stanford-crypto-aes;82;82;81;82;81;83;81;89;83;90 18:07:37 INFO - PROCESS | 14906 | |11;stanford-crypto-ccm;118;118;117;121;122;118;115;118;115;115 18:07:37 INFO - PROCESS | 14906 | |12;stanford-crypto-pbkdf2;147;132;144;138;142;129;145;140;140;139 18:07:37 INFO - PROCESS | 14906 | |13;stanford-crypto-sha256-iterative;67;67;66;66;66;66;66;67;69;65 18:07:37 INFO - PROCESS | 14906 | __end_tp_report 18:07:37 INFO - PROCESS | 14906 | __start_cc_report 18:07:37 INFO - PROCESS | 14906 | _x_x_mozilla_cycle_collect,1111 18:07:37 INFO - PROCESS | 14906 | __end_cc_report 18:07:37 INFO - PROCESS | 14906 | __startTimestamp1458176857332__endTimestamp 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | ------- Summary: start ------- 18:07:37 INFO - PROCESS | 14906 | Number of tests: 14 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.82 (3.4%) stddev-sans-first:4.03 18:07:37 INFO - PROCESS | 14906 | Values: 113.0 114.0 107.0 115.0 115.0 113.0 103.0 113.0 113.0 112.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:155.50 stddev:19.40 (12.5%) stddev-sans-first:20.50 18:07:37 INFO - PROCESS | 14906 | Values: 155.0 131.0 157.0 181.0 131.0 153.0 156.0 129.0 178.0 131.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.60 (1.0%) stddev-sans-first:1.69 18:07:37 INFO - PROCESS | 14906 | Values: 161.0 162.0 159.0 160.0 161.0 161.0 165.0 160.0 161.0 161.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#3] audio-fft Cycles:10 Average:84.00 Median:76.00 stddev:13.48 (17.7%) stddev-sans-first:13.81 18:07:37 INFO - PROCESS | 14906 | Values: 74.0 73.0 99.0 95.0 74.0 74.0 78.0 109.0 92.0 72.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.50 stddev:22.60 (23.9%) stddev-sans-first:23.44 18:07:37 INFO - PROCESS | 14906 | Values: 95.0 95.0 146.0 93.0 94.0 94.0 138.0 95.0 95.0 139.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:07:37 INFO - PROCESS | 14906 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:07:37 INFO - PROCESS | 14906 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:07:37 INFO - PROCESS | 14906 | Values: 96.0 97.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.50 stddev:3.09 (4.7%) stddev-sans-first:3.22 18:07:37 INFO - PROCESS | 14906 | Values: 64.0 64.0 66.0 66.0 65.0 66.0 65.0 74.0 64.0 63.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 18:07:37 INFO - PROCESS | 14906 | Values: 64.0 64.0 64.0 64.0 65.0 65.0 64.0 65.0 65.0 66.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:3.31 (4.0%) stddev-sans-first:3.47 18:07:37 INFO - PROCESS | 14906 | Values: 82.0 82.0 81.0 82.0 81.0 83.0 81.0 89.0 83.0 90.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:118.00 stddev:2.41 (2.0%) stddev-sans-first:2.55 18:07:37 INFO - PROCESS | 14906 | Values: 118.0 118.0 117.0 121.0 122.0 118.0 115.0 118.0 115.0 115.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.60 Median:141.00 stddev:5.60 (4.0%) stddev-sans-first:5.26 18:07:37 INFO - PROCESS | 14906 | Values: 147.0 132.0 144.0 138.0 142.0 129.0 145.0 140.0 140.0 139.0 18:07:37 INFO - PROCESS | 14906 | 18:07:37 INFO - PROCESS | 14906 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 18:07:37 INFO - PROCESS | 14906 | Values: 67.0 67.0 66.0 66.0 66.0 66.0 66.0 67.0 69.0 65.0 18:07:37 INFO - PROCESS | 14906 | -------- Summary: end -------- 18:07:37 INFO - PROCESS | 14906 | 18:07:38 INFO - TEST-INFO | 14906: exit 0 18:07:38 INFO - TEST-OK | kraken | took 61105ms 18:07:38 INFO - SUITE-END | took 1177s 18:07:38 INFO - Completed test suite (00:19:37) 18:07:38 INFO - javascript benchmark 18:07:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2589.3526618345413, 2675.9866200668994, 2677.123038186324, 2693.8922443102265, 2717.6738791345037, 4481.686281960264, 4588.954110458894, 4633.976830115845, 4651.767411629417, 4667.69659972102, 4647.976760116195, 4662.323963025359, 4726.976365118178, 4727.66906316558, 4755.6908800928, 4242.0, 4252.192083504125, 4281.6360609348085, 4314.050908800059, 4375.278079116958, 4219.514755803076, 4318.892027699301, 4330.06903515744, 4337.696361254713, 4373.781310934456, 4279.2725236709675, 4285.46431696038, 4326.653867690608, 4354.608085272341, 4364.323529852878, 4310.978445107786, 4312.698111132222, 4319.0, 4340.956590434118, 4349.652027837797, 4184.727992680497, 4268.253055715269, 4308.375285583604, 4309.030468144674, 4344.652427805768, 4579.542045795427, 4607.562281583244, 4635.629149668019, 4635.814567417333, 4681.227597446417, 4965.503449655042, 4994.675346102528, 4997.150484417622, 5007.173816320303, 5033.597312215014, 4871.926921096151, 4983.626228032876, 5025.547700706918, 5034.899302013976, 5066.695998240118, 4693.06138772247, 4695.460022097503, 4695.647826412965, 4724.834630787906, 4737.289406589005, 5132.923006154911, 5138.87152821175, 5139.177731563007, 5157.922631160535, 5186.170212765939, 4745.454272758608, 4819.397575303087, 4906.337644418029, 4924.162892308316, 4942.5304596063315, 4943.629227807857, 4955.702657840469, 4963.528464795839, 4967.875803104879, 5024.547790698854, 4940.7035577865445, 4944.653874228841, 4945.035718034948, 4946.901061978812, 4998.175301075282, 4756.857294281177, 4897.706137631682, 4955.504449555087, 4997.225430058346, 5002.899942001212, 4248.723832950848, 4254.149170165979, 4264.893377665583, 4267.722598031118, 4310.267254566731, 3684.373656478405, 3734.7572407793405, 3758.4174452959833, 3763.717721170923, 3765.0, 4307.440032795716, 4346.826126954949, 4348.456442944632, 4388.5830846069575, 4390.385346051556, 4929.654924155275, 4971.055499455092, 4975.154223781966, 4976.377952755905, 5003.4746351633285, 4181.163767246563, 4266.424032755538, 4278.101598664315, 4279.3153095505195, 4314.870553883388, 4541.72749635023, 4549.7497637629585, 4550.704204226715, 4588.88527786808, 4593.448786145684, 4742.881427964259, 4767.499412561631, 4768.499307572655, 4770.045990801854, 4812.302216178705, 4875.536824001714, 4942.75286235694, 5025.095482813129, 5032.094223039888, 5043.5460808527405, 4749.786259618257, 4768.66619336657, 4769.9046019080115, 4795.9280610790165, 4818.8795280118275, 4948.752562371795, 4952.306677065286, 4953.380827396575, 4960.826371076995, 5014.272930424995, 4905.313256144072, 4955.207166853286, 5022.472640372708, 5022.623303252198, 5053.29253904461, 4859.562639362474, 4862.0, 4868.878278043077, 4875.463698993037, 4928.556429921181, 4822.903541929212, 4842.661013729146, 4879.926801098058, 4882.951170488392, 4940.431850337257, 4696.272077827942, 4777.665563410528, 4780.211265141213, 4829.323894654822, 4845.297431872429, 4875.731834749123, 4889.731064791471, 4891.584215341593, 4901.534354236342, 4946.332245146859, 4721.716696998191, 4791.041791641616, 4793.664443488922, 4796.304535842353, 4798.760061996956], "unit": "score", "name": "dojo.html", "value": 4595.40210430374}, {"lowerIsBetter": false, "replicates": [525.2488940814635, 530.6842428754892, 541.3666010767402, 547.1628408534941, 560.0535095688284, 28886.566701499494, 35352.64647353532, 35464.46803297952, 35610.287794244134, 35788.0, 37944.0, 38439.23121537568, 38476.0, 38477.80761096197, 38502.22995540088, 7598.77203683889, 7731.922680773177, 7774.572398518079, 7780.766577002699, 7781.182975787546, 7638.809029774272, 7750.457467977244, 7776.688932442696, 7789.06531216252, 7914.762557123267, 7891.092524359686, 7957.0, 7958.681652733883, 7962.5620590867475, 7973.800654983643, 7819.726309579166, 7906.169852165497, 7921.089074756362, 7922.049354077548, 7926.365890728728, 7667.5782831944225, 7773.572453515055, 7789.376849852055, 7791.4156438267355, 7797.415193860483, 37009.0, 37544.81227593872, 37596.62403375959, 37674.43488347677, 37740.245195095944, 2809.4802461544477, 2844.0, 2889.0899366699423, 2895.319599894044, 3048.588440560518, 28468.145955621363, 29278.70721292781, 29449.852750736325, 29594.852025739732, 30092.0, 3246.642869284377, 3256.739460843127, 3260.559824423696, 3346.5482159908343, 3420.452727563603, 244512.0, 245929.0, 246108.0, 246199.0, 246304.9999999982, 52676.473235267156, 53006.0, 53030.469695302556, 53074.469255307726, 53118.0, 67587.0, 69627.65186174138, 69709.0, 69745.65127174332, 69755.0, 14400.567982960529, 14454.349554270084, 14549.709005819825, 14550.27248637564, 14566.41734330615, 11677.299362038304, 11701.941490292664, 11768.88231117695, 11772.941135294268, 11776.764464710657, 19405.51486212828, 19515.60968780645, 19649.90175049144, 19739.605207895762, 19752.209911603375, 7851.685932562634, 8013.398995075393, 8028.598570071473, 8111.351091912633, 8149.8370032600205, 918.2699753695828, 928.3130483442204, 936.1527817325332, 968.4963818814177, 1042.635077722791, 25847.353816154748, 27481.31296717598, 27880.18778779373, 27893.0, 27914.16257512278, 873.912608739121, 969.340848223215, 991.1129539062499, 999.6201443451442, 1001.5977631316216, 12847.48610055606, 12938.0, 12946.158499697489, 13079.280639564726, 13110.737785244242, 275109.0, 277851.0, 280047.0, 280906.0, 281271.0, 46143.30785038227, 46638.76680616575, 46701.5329846704, 46706.53293467022, 46776.766116169885, 1134.7957367673898, 1226.5032661771997, 1227.5396726227486, 1239.4546399584153, 1256.0893352319495, 24243.878780605985, 26118.216453506426, 27002.729972700807, 27051.188464345312, 27084.593731094443, 34989.0, 35369.64630353663, 35377.469337960465, 35408.82295588506, 35481.64518354784, 167286.0, 169285.0, 170657.0, 181025.0, 183258.0, 26831.195064148105, 30784.0, 31305.373892521566, 31649.683503165594, 31857.362852742353, 35323.47014794831, 36404.63595364012, 36708.632913670524, 36714.44928326024, 36888.26223475462, 31634.525482117326, 32127.357452850345, 32864.0, 33170.50244246387, 33325.16687082842, 32592.674073258964, 32644.34711305808, 32704.83647581747, 32771.83614081914, 32917.17707057247, 29833.25416864509, 29958.850205748833, 29971.0, 30137.849310753307, 32210.516842247853, 28445.431091378472, 29041.854790726757, 29509.26226844346, 29523.409531808815, 29593.85203073971, 23159.452460229026, 23305.300840974796, 23334.2999710009, 23574.410639734146, 23704.8814755932], "unit": "score", "name": "ext.html", "value": 16731.09465558831}, {"lowerIsBetter": false, "replicates": [346.1519277769465, 347.65582073747, 348.0862735319786, 359.6942598791026, 362.4599346973009, 12052.276863388191, 12497.500099996001, 12884.871151288484, 15123.848761512381, 15131.31909064092, 14736.6315842104, 15205.163715995615, 15227.162506062163, 15272.84727152731, 15489.612759681013, 4838.782254798533, 5014.648974571782, 5017.749112544377, 5018.397792264915, 5035.874103147414, 4814.590759785422, 4908.116539022974, 4979.626528010395, 5004.62465315101, 5016.423111342187, 4954.455009948902, 4967.577755890754, 4970.602351811846, 4973.477784832595, 4987.426445958725, 4944.876378090558, 4949.455559888409, 4956.578690811303, 5009.373828271466, 5175.120229560984, 4988.925166122511, 5023.874403139914, 5029.446760856303, 5039.0, 5049.5455409013, 11710.941445292805, 11888.167828252026, 14511.854881451156, 17955.461336159937, 18012.729809052875, 1844.6495165918432, 1854.443666899938, 1878.614883948801, 1888.225827410755, 2370.9644355334685, 8339.0, 9009.144131307516, 9294.90705092954, 10889.401082940434, 12831.037672174623, 1799.9280028798833, 1812.465322729798, 1837.4028440756808, 1881.868269221155, 1929.1029671202818, 55113.72443137799, 55823.0, 56501.71749141269, 57509.13736294001, 58773.706131469065, 9983.400995940267, 10120.089191972758, 10135.7466063349, 10238.33450825694, 10250.743731406774, 12901.935490322676, 12999.09006369545, 13027.544035958696, 13033.869661303455, 13045.673858153432, 7092.645367731593, 7130.215676275606, 7172.462065345016, 7271.89092163618, 7275.454340924452, 6781.491388145909, 6829.3170682932305, 6842.794716158523, 6943.236244013155, 6945.0971373721095, 4156.418101465797, 4156.586760501444, 4349.108432771274, 4352.847650332286, 4356.0, 1687.7637130801697, 1798.7122060470263, 1811.112554848115, 1812.209197835319, 1841.677706401401, 806.5967016491754, 834.2241715204797, 839.6011894350257, 895.7581453007651, 933.85992101184, 15187.620309492351, 15413.306401211972, 15570.9221453892, 15737.134457604941, 15743.291551880193, 878.1438097854541, 891.3270480786964, 898.2679116520015, 927.1238679447991, 930.2279108340061, 8823.250023748053, 8910.287177025823, 8914.910850891409, 8959.148880856308, 9100.681476148304, 421523.0, 431027.0, 434138.0, 435165.0, 447253.0, 61931.0, 64388.35611643917, 64803.675981620734, 65028.67485662542, 65050.67474662596, 925.1997022575424, 938.671464987249, 938.8732521109699, 952.476138124029, 952.7332346942867, 13695.589132326046, 13972.441102355791, 14094.718105638034, 14133.858661413666, 14301.713965720835, 29571.704282956896, 31399.0, 31515.52726709147, 31959.68040319567, 32148.517772233903, 41295.7935210322, 44699.0, 44801.77599111984, 44966.550334496234, 45473.0, 7269.382102521345, 7439.51643143194, 7442.9255707442235, 7463.141738700119, 7641.426892982938, 11126.61056863006, 11138.27601205919, 11173.385463799244, 11190.944045280046, 11192.496337664661, 10143.391396515937, 10284.228682848965, 10387.0, 10398.27212095146, 10530.894691053298, 9909.0, 10113.5448904798, 10122.898771012196, 10185.592576296865, 10310.587576496857, 10313.690589282334, 10388.42863642507, 10448.791024179625, 10471.10995565355, 10624.52189651483, 7578.393728501596, 7626.771196864103, 7698.961505192438, 7791.571463569331, 7792.88310675329, 9691.12779849817, 10260.076593106656, 10419.895801041892, 10430.217733669853, 10530.684079477627], "unit": "score", "name": "jquery.html", "value": 7811.966436037124}, {"lowerIsBetter": false, "replicates": [1242.173954320377, 1400.8038874557565, 1429.0354011042543, 1567.1615685608201, 1781.3943259291839, 7210.60341681208, 7360.5215660982, 7380.151282602503, 7387.0, 7404.148522919866, 7214.747483838067, 7371.373433258166, 7374.446916481272, 7380.852382952337, 7383.778486645409, 1897.7058555923784, 1943.9125239364262, 2164.8809315487642, 2185.8142057925056, 2215.667649852519, 2236.329101269621, 2253.5943530164564, 2255.3684968208927, 2256.0524579676576, 2256.244158207003, 2137.2519618133683, 2165.339571430713, 2177.6515757478805, 2214.6235140026156, 2220.0786673530465, 2147.7207962964712, 2167.9241226557074, 2180.3894909425308, 2183.2795177591356, 2184.344696591016, 2171.392010237136, 2203.5923354179527, 2208.1498623030247, 2208.8122509586706, 2211.0271480548668, 7245.4928155029165, 7298.306660867209, 7308.976743255948, 7315.926840731578, 7320.1215854097845, 4475.932861007088, 4588.655850811169, 4611.815527378901, 4612.7924243409125, 4613.746243956581, 2887.422515496888, 2919.7368485991205, 3017.321102751885, 3061.938761224763, 3066.3100802319523, 945.9668911588061, 962.8459446488528, 973.732223638505, 998.9500524973795, 1018.2312354172626, 10329.483525823678, 10344.741381465448, 10347.120494757955, 10357.274990750651, 10358.482075896174, 4139.317012692872, 4233.491980962304, 4255.914881702349, 4316.956830431718, 4332.068605249887, 8886.289096872364, 8910.153535414125, 8912.55437228136, 8924.55377231136, 8953.686620968236, 4520.276755719135, 4530.478994915561, 4545.2954792007295, 4548.363229147922, 4555.476120246214, 3640.8543658253902, 3712.1462063724953, 4019.794061781454, 4093.2427500912427, 4142.792860357031, 3476.3568739783223, 3523.4010218262956, 3580.2660454606744, 3592.3354179476883, 3611.6930060945115, 1146.4611632532697, 1178.8290697848936, 1185.359905650956, 1190.9047276217882, 1196.7606478704295, 923.5520772425368, 961.8557216417454, 1157.9478923448296, 1172.4841069929205, 1183.8638556566104, 6764.5603035802515, 6791.660416979132, 6797.490188235902, 6831.11195544586, 6837.076994605764, 1051.9684409467727, 1062.436908438529, 1069.4064794039382, 1070.1011150633506, 1087.7389426537575, 5024.422191447957, 5034.546890779848, 5069.645124841226, 5075.8984820303385, 5075.97462012695, 8832.955835220782, 9087.681931132378, 9109.863352049724, 9306.627734890528, 9306.813863722688, 9092.454452732858, 9113.863292050624, 9164.908350916405, 9213.12475314844, 9223.169914707709, 7126.465515086389, 7193.532420392762, 7281.56310621375, 7313.378362839218, 7317.780466586011, 6673.833154171185, 6691.966540167463, 6714.0, 6715.731370745116, 6756.223034350916, 8142.796430089295, 8205.097439281555, 8269.95865020671, 8377.246047855722, 8386.329093672613, 8210.548419836967, 8474.067852536093, 8538.060813310407, 8635.0, 8680.348973826862, 6068.271807382966, 6154.78458253959, 6219.0, 6246.937530624818, 6271.278802937721, 7105.893411598727, 7162.570245785269, 7183.461240407095, 7202.603856787927, 7205.171405288459, 6292.2449306081735, 6361.427471527585, 6367.522435817425, 6537.70580323877, 6639.269680335063, 6275.058741188858, 6320.399562041599, 6357.523185760994, 6415.390537898892, 6423.678816059271, 6684.197896252481, 6697.162854643169, 6711.3288671132495, 6722.563033402813, 6740.595564265964, 6066.939330606638, 6081.969590152021, 6132.049532322497, 6132.049532322497, 6154.692265386802, 6173.969130154321, 6189.721462534107, 6204.224471941007, 6216.533759968111, 6231.813045608639], "unit": "score", "name": "mootools.html", "value": 4291.444231145414}, {"lowerIsBetter": false, "replicates": [311.59648255509114, 326.3994250578935, 328.52200048928813, 328.59254524389746, 329.39391519603925, 5351.57187425006, 5435.891282174359, 5437.782488700457, 5443.8094666686675, 5444.455554444554, 5321.388040375358, 5364.651297665649, 5369.006733754249, 5373.785048598052, 5387.676739395629, 4022.3162062449305, 4103.117829666621, 4174.269502837006, 4214.6417554507825, 4224.239636865378, 4183.435236243099, 4210.62104410603, 4222.809973551198, 4229.725067870579, 4243.0, 4177.540470548237, 4185.28850095483, 4187.706860519765, 4195.8741237762915, 4199.727017743852, 3983.3228351180223, 4075.144219713849, 4161.9375709364385, 4164.7709375984305, 4199.580041995807, 3698.056995466166, 3707.7404581679293, 3709.7959612221316, 3710.9814450927843, 3717.851285948586, 5140.665856719302, 5151.974240128813, 5157.0, 5162.174052151638, 5165.605286572604, 4840.830570930036, 4842.927356089662, 4843.709377437365, 4848.0, 4850.854474365775, 5646.40712725162, 5647.898659761348, 5650.576206784508, 5650.830475085713, 5658.321001479849, 4083.5503396294184, 4089.5705950875326, 4090.325096359097, 4092.242935057024, 4097.467329247209, 5764.596478246524, 6018.578699491038, 6019.518438524951, 6024.126501657279, 6030.638161710312, 4011.3180759270995, 4069.7965101745385, 4070.5929407059057, 4073.470448841691, 4074.511058672919, 4128.174365126986, 4129.628333450004, 4133.2146892091005, 4133.318002529549, 4136.896577585524, 4732.810687572459, 4738.976305118453, 4740.976295118502, 4749.382580264612, 4755.286706993909, 5709.286339207599, 5716.714164291769, 5717.171010203498, 5719.513841323451, 5729.083346664514, 1482.6460754656807, 1494.4993427201791, 1517.1883042572172, 1518.8025556677562, 1519.4302136698739, 941.5480569326761, 1002.6490728245055, 1038.1798379280435, 1054.5360041581832, 1058.576569372242, 4904.313396124546, 4912.680675756064, 4913.31213630092, 4917.213245880642, 4937.1113199624415, 5843.0, 5848.707564621752, 5854.326752423441, 5855.092460668518, 5858.443447872445, 4958.950410495849, 4960.181570040902, 4970.105381031377, 4971.527704868032, 4972.7513624318635, 3092.9536056959164, 3121.360121175154, 3121.5005599104034, 3123.515855042472, 3126.4685003549453, 5486.670799752028, 5499.862503437366, 5516.9448305517235, 5518.227448157181, 5521.4478552144465, 5913.526917846562, 6140.969295153495, 6145.10895920098, 6147.415995480422, 6148.262208535004, 5590.972045139748, 5622.240997465372, 5626.437356264504, 5629.971850140723, 5631.887362252732, 5963.373845746308, 5978.491828194652, 5979.581429300081, 5980.312264089512, 5982.4316689914385, 5852.268466441695, 5858.794942177004, 5861.443162899518, 5867.559933005127, 5870.148828419769, 5386.13821788512, 5615.2700148980375, 5616.494515493625, 5618.129189975561, 5621.072523033654, 4010.7794071326357, 4068.3083875740604, 4085.5301640310554, 4090.611391917763, 4092.1815636872147, 5917.0, 5926.851828704317, 5931.1399847021075, 5931.5847890648965, 5938.406159384027, 5698.914516282176, 5715.199872018004, 5722.484976352148, 5731.398203188605, 5738.110592858114, 5683.460071293221, 5702.34423041339, 5711.571632127524, 5726.885462290814, 5729.828105156852, 5405.108157154025, 5585.5531557476115, 5603.159526071122, 5617.382087970402, 5629.043062679436, 5707.08686610157, 5716.114002329646, 5775.364709881826, 5788.450097240755, 5798.391168927202, 5668.489835914787, 5672.262605861211, 5679.119736440858, 5679.659220446786, 5680.204771331934], "unit": "score", "name": "prototype.html", "value": 4293.010384324507}, {"lowerIsBetter": false, "replicates": [608.7960533221368, 626.2578844069781, 671.0906721392513, 703.6516924122559, 726.7674344209852, 11474.082073434127, 11593.304401735903, 11634.709132271677, 11647.475863586127, 11656.41717914104, 11705.648830535098, 11715.062794976402, 11743.941280293586, 11754.118441116907, 11755.941220293907, 627.9811605651815, 766.9616519174047, 776.0493395590413, 777.1334961517895, 798.3852433626133, 788.6569342336102, 791.3036527855479, 794.3724457678427, 794.7297918707638, 794.8171920458298, 837.6691206973272, 838.8573942429801, 840.1388576708861, 841.3941961787503, 842.616609442702, 660.2802944790178, 823.3125340340792, 829.1087081387502, 837.5812093953024, 838.446625227347, 615.6183166436838, 615.8737458820931, 616.0082267549242, 616.6392660293734, 616.7502161624549, 11825.526978920832, 11987.88012119885, 11998.400079996052, 12003.219790713576, 12009.219400739012, 11571.594994175164, 12074.758504829853, 12187.756244875052, 12303.32331721755, 12476.313802740846, 9472.0, 9628.951855240679, 9872.1608663263, 10051.447170405625, 10072.94963525185, 3339.1652086978256, 3367.3938691035605, 3382.780119292238, 3400.387930172568, 3484.564429446319, 41806.79096604497, 41876.37185442221, 42028.15943681109, 42054.1589168218, 42134.0, 9677.661281855102, 9894.80210395788, 9987.700368988943, 10038.247131465023, 10251.487425628839, 17321.65356692859, 17329.7400538992, 17453.21460534279, 17462.126893655266, 17557.385491507735, 6659.966700166468, 6661.3005634408655, 6740.494462915203, 6741.966290168518, 6934.965325173443, 3675.3751862183494, 3689.335919534456, 3713.851445942132, 3755.8685446009804, 3801.828917698655, 2793.273748825279, 2804.8737806798745, 2808.536591462386, 2816.7464928156564, 2837.815541989764, 522.9372475302988, 525.136151031551, 528.3791544934686, 537.4007981101045, 540.8674874655735, 410.6406893967778, 450.916580432621, 459.48996613758703, 529.4573062610855, 551.4402881075712, 6705.463562914955, 7599.65801538921, 7686.769396918102, 7720.15078341382, 7922.603869806487, 434.97825108744433, 477.6369958831313, 486.637296635663, 525.1807180797967, 527.1565495207637, 3383.6278009418943, 3491.5984661763714, 3497.6852083312624, 3497.89506314811, 3634.818259087035, 49318.013639727, 49427.0, 49581.25628115581, 49721.0, 49797.75101124471, 41555.0, 41891.581084188765, 41918.0, 41977.0, 42757.78621106874, 39310.0, 41126.0, 41214.38178427326, 42396.152076958286, 45139.54860451353, 7864.606769661608, 7875.409344299315, 7904.881426778488, 8028.558429286445, 8214.671413143407, 31667.20831979219, 32047.198820029687, 32995.505067424485, 33046.504302435, 33159.33681326408, 40096.0, 41677.1664566713, 41717.16565668609, 41780.16439671129, 42265.78867105645, 9815.067568580973, 9819.312648114563, 9930.304878658424, 9988.45351424483, 10103.696889093339, 10099.192064634959, 10231.693049208536, 10297.897021029694, 10333.121684656588, 10543.209259305737, 10645.361278323326, 10840.132789376674, 10870.891291086988, 10888.61889833852, 10931.344119352865, 10705.456274988865, 10926.781464370828, 11044.447777611247, 11099.0, 11285.025504856521, 9867.309288350034, 10078.344907580984, 10118.291719579558, 10244.795104097728, 10301.74245643865, 8296.294814940798, 8551.444156129832, 8712.695055673275, 8727.389082764146, 8851.424657397249, 8414.284785793276, 8668.696595619123, 8811.118888111137, 9143.497107659143, 9307.11582399671], "unit": "score", "name": "yui.html", "value": 5701.828514090666}], "name": "dromaeo_css", "value": 6309.644637650144}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 107.0, 115.0, 115.0, 113.0, 103.0, 113.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [155.0, 131.0, 157.0, 181.0, 131.0, 153.0, 156.0, 129.0, 178.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 159.0, 160.0, 161.0, 161.0, 165.0, 160.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 99.0, 95.0, 74.0, 74.0, 78.0, 109.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 146.0, 93.0, 94.0, 94.0, 138.0, 95.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 66.0, 66.0, 65.0, 66.0, 65.0, 74.0, 64.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 65.7}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 81.0, 82.0, 81.0, 83.0, 81.0, 89.0, 83.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 121.0, 122.0, 118.0, 115.0, 118.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.7}, {"lowerIsBetter": true, "replicates": [147.0, 132.0, 144.0, 138.0, 142.0, 129.0, 145.0, 140.0, 140.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 69.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1512.3}]} 18:07:38 INFO - Return code: 0 18:07:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:07:38 ERROR - # TBPL SUCCESS # 18:07:38 INFO - Running post-action listener: _resource_record_post_action 18:07:38 INFO - Running post-run listener: _resource_record_post_run 18:07:39 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 519888896; Read time: 0; Write time: 392048 18:07:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 232316928; Read time: 0; Write time: 199228 18:07:39 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 287571968; Read time: 0; Write time: 192820 18:07:39 INFO - Running post-run listener: _upload_blobber_files 18:07:39 INFO - Blob upload gear active. 18:07:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:07:39 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 18:07:39 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'] 18:07:39 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 18:07:40 INFO - (blobuploader) - INFO - Open directory for files ... 18:07:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:07:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:07:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:40 INFO - (blobuploader) - INFO - Done attempting. 18:07:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:07:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:07:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:41 INFO - (blobuploader) - INFO - Done attempting. 18:07:41 INFO - (blobuploader) - INFO - Iteration through files over. 18:07:41 INFO - Return code: 0 18:07:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:07:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:07:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b4477ebf94c4bf29c34f1de76ee3fa301dd4402cd720e88077ac7bd63cd77e76ccea4ca579fccd208edce64cb6e3ff8cd1f885a03332b265752cff08729b0b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbdfc3f915cf7719206d2db45c61a5fe1dc86a3df4e5898434d7e8bf2ba8fda47655d092aea8371bd609e5fe81d0ae20ac09dd983708105ae454bcbfb77dc262"} 18:07:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:07:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:07:41 INFO - Contents: 18:07:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b4477ebf94c4bf29c34f1de76ee3fa301dd4402cd720e88077ac7bd63cd77e76ccea4ca579fccd208edce64cb6e3ff8cd1f885a03332b265752cff08729b0b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbdfc3f915cf7719206d2db45c61a5fe1dc86a3df4e5898434d7e8bf2ba8fda47655d092aea8371bd609e5fe81d0ae20ac09dd983708105ae454bcbfb77dc262"} 18:07:41 INFO - Running post-run listener: copy_logs_to_upload_dir 18:07:41 INFO - Copying logs to upload dir... 18:07:41 INFO - mkdir: /builds/slave/test/build/upload/logs 18:07:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.243352 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-16 18:07:40.927585) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 18:07:40.930664) ========= 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=6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035 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/5b4477ebf94c4bf29c34f1de76ee3fa301dd4402cd720e88077ac7bd63cd77e76ccea4ca579fccd208edce64cb6e3ff8cd1f885a03332b265752cff08729b0b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbdfc3f915cf7719206d2db45c61a5fe1dc86a3df4e5898434d7e8bf2ba8fda47655d092aea8371bd609e5fe81d0ae20ac09dd983708105ae454bcbfb77dc262"} build_url:https://queue.taskcluster.net/v1/task/As1fkxKDQYigrDPAvN1aMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/As1fkxKDQYigrDPAvN1aMg/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/5b4477ebf94c4bf29c34f1de76ee3fa301dd4402cd720e88077ac7bd63cd77e76ccea4ca579fccd208edce64cb6e3ff8cd1f885a03332b265752cff08729b0b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbdfc3f915cf7719206d2db45c61a5fe1dc86a3df4e5898434d7e8bf2ba8fda47655d092aea8371bd609e5fe81d0ae20ac09dd983708105ae454bcbfb77dc262"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 18:07:40.960549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 18:07:40.961411) ========= 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=6dbc10da6d83fee962c624be000001a8-1458175311.746603-1640305035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 18:07:41.044191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 18:07:41.044983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 18:07:41.045501) ========= ========= Total master_lag: 0.31 =========