builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1458935916.96 results: success (0) buildid: 20160325114532 builduid: c3cb6d07207c4a65bfe9d71ece9591fe revision: fe11700b6cdfdb0fca3a9b2a54bf6d339792df24 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:36.956820) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:36.957216) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:36.957510) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:36.988043) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:36.988311) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.032109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.032368) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.085521) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.085798) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.086129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.086399) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-25 12:58:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2016-03-25 12:58:37 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.228777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.329166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.329476) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019540 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.379034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.379333) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fe11700b6cdfdb0fca3a9b2a54bf6d339792df24 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fe11700b6cdfdb0fca3a9b2a54bf6d339792df24 --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=5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-25 12:58:37,724 truncating revision to first 12 chars 2016-03-25 12:58:37,724 Setting DEBUG logging. 2016-03-25 12:58:37,724 attempt 1/10 2016-03-25 12:58:37,724 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fe11700b6cdf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 12:58:37,982 unpacking tar archive at: fx-team-fe11700b6cdf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549622 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.943262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.943561) ========= echo fe11700b6cdfdb0fca3a9b2a54bf6d339792df24 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fe11700b6cdfdb0fca3a9b2a54bf6d339792df24'] 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=5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fe11700b6cdfdb0fca3a9b2a54bf6d339792df24 program finished with exit code 0 elapsedTime=0.004838 script_repo_revision: 'fe11700b6cdfdb0fca3a9b2a54bf6d339792df24' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.996927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:37.997199) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 12:58:38.007407) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-25 12:58:38.007676) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:58:38 INFO - MultiFileLogger online at 20160325 12:58:38 in /builds/slave/test 12:58:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:58:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:58:38 INFO - {'append_to_log': False, 12:58:38 INFO - 'base_work_dir': '/builds/slave/test', 12:58:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:58:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:58:38 INFO - 'branch': 'Fx-Team-Non-PGO', 12:58:38 INFO - 'buildbot_json_path': 'buildprops.json', 12:58:38 INFO - 'config_files': ('talos/linux_config.py',), 12:58:38 INFO - 'default_actions': ('clobber', 12:58:38 INFO - 'read-buildbot-config', 12:58:38 INFO - 'download-and-extract', 12:58:38 INFO - 'populate-webroot', 12:58:38 INFO - 'create-virtualenv', 12:58:38 INFO - 'install', 12:58:38 INFO - 'run-tests'), 12:58:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:58:38 INFO - 'download_minidump_stackwalk': True, 12:58:38 INFO - 'download_symbols': 'ondemand', 12:58:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:58:38 INFO - 'tooltool.py': '/tools/tooltool.py', 12:58:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:58:38 INFO - '/tools/misc-python/virtualenv.py')}, 12:58:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:58:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:58:38 INFO - 'installer_path': 'installer.exe', 12:58:38 INFO - 'log_level': 'info', 12:58:38 INFO - 'log_name': 'talos', 12:58:38 INFO - 'log_to_console': True, 12:58:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:58:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:58:38 INFO - 'opt_config_files': (), 12:58:38 INFO - 'pip_index': False, 12:58:38 INFO - 'sps_profile': False, 12:58:38 INFO - 'sps_profile_interval': 0, 12:58:38 INFO - 'suite': 'dromaeojs', 12:58:38 INFO - 'system_bits': '32', 12:58:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:58:38 INFO - 'title': 'talos-linux64-ix-011', 12:58:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:58:38 INFO - 'use_talos_json': True, 12:58:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:58:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:58:38 INFO - 'work_dir': 'build'} 12:58:38 INFO - ##### 12:58:38 INFO - ##### Running clobber step. 12:58:38 INFO - ##### 12:58:38 INFO - Running pre-action listener: _resource_record_pre_action 12:58:38 INFO - Running main action method: clobber 12:58:38 INFO - rmtree: /builds/slave/test/build 12:58:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:58:38 INFO - Running post-action listener: _resource_record_post_action 12:58:38 INFO - ##### 12:58:38 INFO - ##### Running read-buildbot-config step. 12:58:38 INFO - ##### 12:58:38 INFO - Running pre-action listener: _resource_record_pre_action 12:58:38 INFO - Running main action method: read_buildbot_config 12:58:38 INFO - Using buildbot properties: 12:58:38 INFO - { 12:58:38 INFO - "project": "", 12:58:38 INFO - "product": "firefox", 12:58:38 INFO - "script_repo_revision": "production", 12:58:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:58:38 INFO - "repository": "", 12:58:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:58:38 INFO - "buildid": "20160325114532", 12:58:38 INFO - "pgo_build": "False", 12:58:38 INFO - "basedir": "/builds/slave/test", 12:58:38 INFO - "buildnumber": 2692, 12:58:38 INFO - "slavename": "talos-linux64-ix-011", 12:58:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:58:38 INFO - "platform": "ubuntu64_hw", 12:58:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:58:38 INFO - "branch": "fx-team", 12:58:38 INFO - "repo_path": "integration/fx-team", 12:58:38 INFO - "revision": "fe11700b6cdfdb0fca3a9b2a54bf6d339792df24", 12:58:38 INFO - "stage_platform": "linux64", 12:58:38 INFO - "builduid": "c3cb6d07207c4a65bfe9d71ece9591fe", 12:58:38 INFO - "slavebuilddir": "test" 12:58:38 INFO - } 12:58:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:58:38 INFO - Running post-action listener: _resource_record_post_action 12:58:38 INFO - ##### 12:58:38 INFO - ##### Running download-and-extract step. 12:58:38 INFO - ##### 12:58:38 INFO - Running pre-action listener: _resource_record_pre_action 12:58:38 INFO - Running main action method: download_and_extract 12:58:38 INFO - mkdir: /builds/slave/test/build/tests 12:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:38 INFO - https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:58:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:58:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:58:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/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 12:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/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 12:58:44 INFO - Downloaded 1361 bytes. 12:58:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:58:44 INFO - Using the following test package requirements: 12:58:44 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:58:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:58:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:58:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:44 INFO - u'jsshell-linux-x86_64.zip'], 12:58:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:58:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:58:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:58:44 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:58:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:58:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:58:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:58:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:44 INFO - https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/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 12:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/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 12:58:48 INFO - Downloaded 22085406 bytes. 12:58:48 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'] 12:58:48 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 12:58:49 INFO - Return code: 0 12:58:49 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 12:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:49 INFO - https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:58:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:58:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:58:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/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 12:58:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/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 12:58:50 INFO - Downloaded 22085406 bytes. 12:58:50 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'] 12:58:50 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 12:58:52 INFO - Return code: 0 12:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:52 INFO - https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:58:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:58:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:58:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/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 12:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/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 12:58:53 INFO - Downloaded 10847531 bytes. 12:58:53 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'] 12:58:53 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 12:58:53 INFO - Return code: 0 12:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:53 INFO - https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:58:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:58:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:58:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/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 12:58:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/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 12:58:54 INFO - Downloaded 54258933 bytes. 12:58:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:58:54 INFO - mkdir: /builds/slave/test/properties 12:58:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:58:54 INFO - Writing to file /builds/slave/test/properties/build_url 12:58:54 INFO - Contents: 12:58:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:58:55 INFO - Running post-action listener: _resource_record_post_action 12:58:56 INFO - Running post-action listener: set_extra_try_arguments 12:58:56 INFO - ##### 12:58:56 INFO - ##### Running populate-webroot step. 12:58:56 INFO - ##### 12:58:56 INFO - Running pre-action listener: _resource_record_pre_action 12:58:56 INFO - Running main action method: populate_webroot 12:58:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:58:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:58:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:58:56 INFO - '--tppagecycles', 12:58:56 INFO - '7'], 12:58:56 INFO - 'tests': ['tsvgm']}}, 12:58:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:58:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:58:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:58:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:58:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:58:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:58:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:56 INFO - 'talos_options': ['--e10s'], 12:58:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:56 INFO - 'tests': ['damp', 'tps']}, 12:58:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:56 INFO - 'talos_options': ['--e10s'], 12:58:56 INFO - 'tests': ['damp', 'tps']}, 12:58:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:58:56 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 12:58:56 INFO - 'tests': ['dromaeo_dom']}, 12:58:56 INFO - 'other': {'tests': ['a11yr', 12:58:56 INFO - 'ts_paint', 12:58:56 INFO - 'tpaint', 12:58:56 INFO - 'sessionrestore', 12:58:56 INFO - 'sessionrestore_no_auto_restore', 12:58:56 INFO - 'tabpaint']}, 12:58:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:58:56 INFO - 'tests': ['a11yr', 12:58:56 INFO - 'ts_paint', 12:58:56 INFO - 'tpaint', 12:58:56 INFO - 'sessionrestore', 12:58:56 INFO - 'sessionrestore_no_auto_restore', 12:58:56 INFO - 'tabpaint']}, 12:58:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:58:56 INFO - 'tests': ['a11yr', 12:58:56 INFO - 'ts_paint', 12:58:56 INFO - 'tpaint', 12:58:56 INFO - 'sessionrestore', 12:58:56 INFO - 'sessionrestore_no_auto_restore', 12:58:56 INFO - 'tabpaint']}, 12:58:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:58:56 INFO - 'tests': ['a11yr', 12:58:56 INFO - 'ts_paint', 12:58:56 INFO - 'tpaint', 12:58:56 INFO - 'sessionrestore', 12:58:56 INFO - 'sessionrestore_no_auto_restore', 12:58:56 INFO - 'tabpaint']}, 12:58:56 INFO - 'other_l64': {'tests': ['a11yr', 12:58:56 INFO - 'ts_paint', 12:58:56 INFO - 'tpaint', 12:58:56 INFO - 'sessionrestore', 12:58:56 INFO - 'sessionrestore_no_auto_restore', 12:58:56 INFO - 'tabpaint']}, 12:58:56 INFO - 'other_nol64': {'tests': ['a11yr', 12:58:56 INFO - 'ts_paint', 12:58:56 INFO - 'tpaint', 12:58:56 INFO - 'sessionrestore', 12:58:56 INFO - 'sessionrestore_no_auto_restore', 12:58:56 INFO - 'tabpaint']}, 12:58:56 INFO - 'svgr': {'tests': ['tsvgx', 12:58:56 INFO - 'tsvgr_opacity', 12:58:56 INFO - 'tart', 12:58:56 INFO - 'tscrollx', 12:58:56 INFO - 'cart']}, 12:58:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:58:56 INFO - 'tests': ['tsvgx', 12:58:56 INFO - 'tsvgr_opacity', 12:58:56 INFO - 'tart', 12:58:56 INFO - 'tscrollx', 12:58:56 INFO - 'cart']}, 12:58:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:56 INFO - 'tests': ['tp5o']}, 12:58:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:56 INFO - 'talos_options': ['--e10s'], 12:58:56 INFO - 'tests': ['tp5o']}, 12:58:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:56 INFO - 'talos_options': ['--xperf_path', 12:58:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:56 INFO - 'tests': ['tp5n']}, 12:58:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:56 INFO - 'talos_options': ['--e10s', 12:58:56 INFO - '--xperf_path', 12:58:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:56 INFO - 'tests': ['tp5n']}}, 12:58:56 INFO - 'talos.zip': {'path': '', 12:58:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:58:56 INFO - Running post-action listener: _resource_record_post_action 12:58:56 INFO - ##### 12:58:56 INFO - ##### Running create-virtualenv step. 12:58:56 INFO - ##### 12:58:56 INFO - Running pre-action listener: _resource_record_pre_action 12:58:56 INFO - Running main action method: create_virtualenv 12:58:56 INFO - Creating virtualenv /builds/slave/test/build/venv 12:58:56 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 12:58:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:58:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:58:56 INFO - Using real prefix '/usr' 12:58:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:58:56 INFO - Installing distribute.............................................................................................................................................................................................done. 12:58:58 INFO - Installing pip.................done. 12:58:58 INFO - Return code: 0 12:58:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85942dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', '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 12:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:58:58 INFO - Using env: {'DISPLAY': ':0', 12:58:58 INFO - 'HOME': '/home/cltbld', 12:58:58 INFO - 'LANG': 'en_US.UTF-8', 12:58:58 INFO - 'LANGUAGE': 'en_US:en', 12:58:58 INFO - 'LOGNAME': 'cltbld', 12:58:58 INFO - 'MAIL': '/var/mail/cltbld', 12:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:58 INFO - 'MOZ_NO_REMOTE': '1', 12:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:58 INFO - 'NO_EM_RESTART': '1', 12:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:58 INFO - 'PWD': '/builds/slave/test', 12:58:58 INFO - 'SHELL': '/bin/bash', 12:58:58 INFO - 'SHLVL': '1', 12:58:58 INFO - 'TERM': 'linux', 12:58:58 INFO - 'TMOUT': '86400', 12:58:58 INFO - 'USER': 'cltbld', 12:58:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', 12:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:58 INFO - '_': '/tools/buildbot/bin/python'} 12:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:58 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 12:58:58 INFO - Cleaning up... 12:58:59 INFO - Return code: 0 12:58:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:58: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')]} 12:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58: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')]} 12:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:59 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 0x7f85942dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', '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 12:58:59 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 12:58:59 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 12:58:59 INFO - Using env: {'DISPLAY': ':0', 12:58:59 INFO - 'HOME': '/home/cltbld', 12:58:59 INFO - 'LANG': 'en_US.UTF-8', 12:58:59 INFO - 'LANGUAGE': 'en_US:en', 12:58:59 INFO - 'LOGNAME': 'cltbld', 12:58:59 INFO - 'MAIL': '/var/mail/cltbld', 12:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:59 INFO - 'MOZ_NO_REMOTE': '1', 12:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:59 INFO - 'NO_EM_RESTART': '1', 12:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:59 INFO - 'PWD': '/builds/slave/test', 12:58:59 INFO - 'SHELL': '/bin/bash', 12:58:59 INFO - 'SHLVL': '1', 12:58:59 INFO - 'TERM': 'linux', 12:58:59 INFO - 'TMOUT': '86400', 12:58:59 INFO - 'USER': 'cltbld', 12:58:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', 12:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:59 INFO - '_': '/tools/buildbot/bin/python'} 12:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:59 INFO - Downloading/unpacking psutil>=0.7.1 12:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:59:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:01 INFO - Installing collected packages: psutil 12:59:01 INFO - Running setup.py install for psutil 12:59:01 INFO - building 'psutil._psutil_linux' extension 12:59:01 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 12:59:01 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 12:59:01 INFO - building 'psutil._psutil_posix' extension 12:59:01 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 12:59:01 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 12:59:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:01 INFO - Successfully installed psutil 12:59:01 INFO - Cleaning up... 12:59:01 INFO - Return code: 0 12:59:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f85942dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', '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 12:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:59:01 INFO - Using env: {'DISPLAY': ':0', 12:59:01 INFO - 'HOME': '/home/cltbld', 12:59:01 INFO - 'LANG': 'en_US.UTF-8', 12:59:01 INFO - 'LANGUAGE': 'en_US:en', 12:59:01 INFO - 'LOGNAME': 'cltbld', 12:59:01 INFO - 'MAIL': '/var/mail/cltbld', 12:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:01 INFO - 'MOZ_NO_REMOTE': '1', 12:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:01 INFO - 'NO_EM_RESTART': '1', 12:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:01 INFO - 'PWD': '/builds/slave/test', 12:59:01 INFO - 'SHELL': '/bin/bash', 12:59:01 INFO - 'SHLVL': '1', 12:59:01 INFO - 'TERM': 'linux', 12:59:01 INFO - 'TMOUT': '86400', 12:59:01 INFO - 'USER': 'cltbld', 12:59:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', 12:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:01 INFO - '_': '/tools/buildbot/bin/python'} 12:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:59:03 INFO - Installing collected packages: mozsystemmonitor 12:59:03 INFO - Running setup.py install for mozsystemmonitor 12:59:03 INFO - Successfully installed mozsystemmonitor 12:59:03 INFO - Cleaning up... 12:59:04 INFO - Return code: 0 12:59:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f85942dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', '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 12:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:59:04 INFO - Using env: {'DISPLAY': ':0', 12:59:04 INFO - 'HOME': '/home/cltbld', 12:59:04 INFO - 'LANG': 'en_US.UTF-8', 12:59:04 INFO - 'LANGUAGE': 'en_US:en', 12:59:04 INFO - 'LOGNAME': 'cltbld', 12:59:04 INFO - 'MAIL': '/var/mail/cltbld', 12:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:04 INFO - 'MOZ_NO_REMOTE': '1', 12:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:04 INFO - 'NO_EM_RESTART': '1', 12:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:04 INFO - 'PWD': '/builds/slave/test', 12:59:04 INFO - 'SHELL': '/bin/bash', 12:59:04 INFO - 'SHLVL': '1', 12:59:04 INFO - 'TERM': 'linux', 12:59:04 INFO - 'TMOUT': '86400', 12:59:04 INFO - 'USER': 'cltbld', 12:59:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', 12:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:04 INFO - '_': '/tools/buildbot/bin/python'} 12:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:04 INFO - Downloading/unpacking blobuploader==1.2.4 12:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:06 INFO - Downloading blobuploader-1.2.4.tar.gz 12:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:59:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:59:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:06 INFO - Downloading docopt-0.6.1.tar.gz 12:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:59:06 INFO - Installing collected packages: blobuploader, requests, docopt 12:59:06 INFO - Running setup.py install for blobuploader 12:59:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:59:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:59:06 INFO - Running setup.py install for requests 12:59:07 INFO - Running setup.py install for docopt 12:59:07 INFO - Successfully installed blobuploader requests docopt 12:59:07 INFO - Cleaning up... 12:59:07 INFO - Return code: 0 12:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59: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')]} 12:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59: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')]} 12:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:07 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 0x7f85942dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', '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 12:59:07 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 12:59:07 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 12:59:07 INFO - Using env: {'DISPLAY': ':0', 12:59:07 INFO - 'HOME': '/home/cltbld', 12:59:07 INFO - 'LANG': 'en_US.UTF-8', 12:59:07 INFO - 'LANGUAGE': 'en_US:en', 12:59:07 INFO - 'LOGNAME': 'cltbld', 12:59:07 INFO - 'MAIL': '/var/mail/cltbld', 12:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:07 INFO - 'MOZ_NO_REMOTE': '1', 12:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:07 INFO - 'NO_EM_RESTART': '1', 12:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:07 INFO - 'PWD': '/builds/slave/test', 12:59:07 INFO - 'SHELL': '/bin/bash', 12:59:07 INFO - 'SHLVL': '1', 12:59:07 INFO - 'TERM': 'linux', 12:59:07 INFO - 'TMOUT': '86400', 12:59:07 INFO - 'USER': 'cltbld', 12:59:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', 12:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:07 INFO - '_': '/tools/buildbot/bin/python'} 12:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:59:07 INFO - Running setup.py (path:/tmp/pip-sDN9uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:59:07 INFO - Running setup.py (path:/tmp/pip-8GVK3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:59:07 INFO - Running setup.py (path:/tmp/pip-07X2H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:59:07 INFO - Running setup.py (path:/tmp/pip-Aw_QlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:59:07 INFO - Running setup.py (path:/tmp/pip-gJXSKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:59:08 INFO - Running setup.py (path:/tmp/pip-i5UGIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:59:08 INFO - Running setup.py (path:/tmp/pip-fF7TQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:59:08 INFO - Running setup.py (path:/tmp/pip-p89Zq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:59:08 INFO - Running setup.py (path:/tmp/pip-_ttnqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:59:08 INFO - Running setup.py (path:/tmp/pip-Khirwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:59:08 INFO - Running setup.py (path:/tmp/pip-ECs8bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:59:08 INFO - Running setup.py (path:/tmp/pip-yFds_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:59:08 INFO - Running setup.py (path:/tmp/pip-y70kO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:59:08 INFO - Running setup.py (path:/tmp/pip-vbTgKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:08 INFO - Running setup.py (path:/tmp/pip-TSLiW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:59:08 INFO - Running setup.py (path:/tmp/pip-LfkDft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:59:08 INFO - Running setup.py (path:/tmp/pip-bIfjgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:59:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:59:08 INFO - Running setup.py install for manifestparser 12:59:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:59:08 INFO - Running setup.py install for mozcrash 12:59:09 INFO - Running setup.py install for mozdebug 12:59:09 INFO - Running setup.py install for mozdevice 12:59:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:59:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:59:09 INFO - Running setup.py install for mozfile 12:59:09 INFO - Running setup.py install for mozhttpd 12:59:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:59:09 INFO - Running setup.py install for mozinfo 12:59:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:59:09 INFO - Running setup.py install for mozInstall 12:59:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:59:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:59:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:59:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:59:09 INFO - Running setup.py install for mozleak 12:59:09 INFO - Running setup.py install for mozlog 12:59:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:59:09 INFO - Running setup.py install for moznetwork 12:59:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:59:10 INFO - Running setup.py install for mozprocess 12:59:10 INFO - Running setup.py install for mozprofile 12:59:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:59:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:59:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:59:10 INFO - Running setup.py install for mozrunner 12:59:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:59:10 INFO - Running setup.py install for mozscreenshot 12:59:10 INFO - Running setup.py install for moztest 12:59:10 INFO - Running setup.py install for mozversion 12:59:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:59:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:59:10 INFO - Cleaning up... 12:59:10 INFO - Return code: 0 12:59:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59:10 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')]} 12:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:10 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')]} 12:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:10 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 0x7f85942dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', '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 12:59:10 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 12:59:10 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 12:59:10 INFO - Using env: {'DISPLAY': ':0', 12:59:10 INFO - 'HOME': '/home/cltbld', 12:59:10 INFO - 'LANG': 'en_US.UTF-8', 12:59:10 INFO - 'LANGUAGE': 'en_US:en', 12:59:10 INFO - 'LOGNAME': 'cltbld', 12:59:10 INFO - 'MAIL': '/var/mail/cltbld', 12:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:10 INFO - 'MOZ_NO_REMOTE': '1', 12:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:10 INFO - 'NO_EM_RESTART': '1', 12:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:10 INFO - 'PWD': '/builds/slave/test', 12:59:10 INFO - 'SHELL': '/bin/bash', 12:59:10 INFO - 'SHLVL': '1', 12:59:10 INFO - 'TERM': 'linux', 12:59:10 INFO - 'TMOUT': '86400', 12:59:10 INFO - 'USER': 'cltbld', 12:59:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', 12:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:10 INFO - '_': '/tools/buildbot/bin/python'} 12:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:59:10 INFO - Running setup.py (path:/tmp/pip-GHFhu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:59:10 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)) 12:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:59:10 INFO - Running setup.py (path:/tmp/pip-RFkidY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:59:11 INFO - Running setup.py (path:/tmp/pip-9OEBrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:59:11 INFO - Running setup.py (path:/tmp/pip-UN3eQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:59:11 INFO - Running setup.py (path:/tmp/pip-YgTzU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:59:11 INFO - Running setup.py (path:/tmp/pip-ZEYhdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:59:11 INFO - Running setup.py (path:/tmp/pip-uc14IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:59:11 INFO - Running setup.py (path:/tmp/pip-y9Izzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:59:11 INFO - Running setup.py (path:/tmp/pip-DP7C4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:59:11 INFO - Running setup.py (path:/tmp/pip-nLNydx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:59:11 INFO - Running setup.py (path:/tmp/pip-Hx8dRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:59:11 INFO - Running setup.py (path:/tmp/pip-U4VGIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:59:11 INFO - Running setup.py (path:/tmp/pip-1MZDsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:59:11 INFO - Running setup.py (path:/tmp/pip-JhnnuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:11 INFO - Running setup.py (path:/tmp/pip-AHcUgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:11 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)) 12:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:59:11 INFO - Running setup.py (path:/tmp/pip-2c1pIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:59:12 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)) 12:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:59:12 INFO - Running setup.py (path:/tmp/pip-ZGsHMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:59:12 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)) 12:59:12 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)) 12:59:12 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)) 12:59:12 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)) 12:59:12 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)) 12:59:12 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)) 12:59:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:13 INFO - Downloading blessings-1.6.tar.gz 12:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:59:14 INFO - Installing collected packages: blessings 12:59:14 INFO - Running setup.py install for blessings 12:59:14 INFO - Successfully installed blessings 12:59:14 INFO - Cleaning up... 12:59:14 INFO - Return code: 0 12:59:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:59:14 INFO - Reading from file tmpfile_stdout 12:59:14 INFO - Current package versions: 12:59:14 INFO - argparse == 1.2.1 12:59:14 INFO - blessings == 1.6 12:59:14 INFO - blobuploader == 1.2.4 12:59:14 INFO - docopt == 0.6.1 12:59:14 INFO - manifestparser == 1.1 12:59:14 INFO - mozInstall == 1.12 12:59:14 INFO - mozcrash == 0.17 12:59:14 INFO - mozdebug == 0.1 12:59:14 INFO - mozdevice == 0.48 12:59:14 INFO - mozfile == 1.2 12:59:14 INFO - mozhttpd == 0.7 12:59:14 INFO - mozinfo == 0.9 12:59:14 INFO - mozleak == 0.1 12:59:14 INFO - mozlog == 3.1 12:59:14 INFO - moznetwork == 0.27 12:59:14 INFO - mozprocess == 0.22 12:59:14 INFO - mozprofile == 0.28 12:59:14 INFO - mozrunner == 6.11 12:59:14 INFO - mozscreenshot == 0.1 12:59:14 INFO - mozsystemmonitor == 0.0 12:59:14 INFO - moztest == 0.7 12:59:14 INFO - mozversion == 1.4 12:59:14 INFO - psutil == 3.1.1 12:59:14 INFO - requests == 1.2.3 12:59:14 INFO - wsgiref == 0.1.2 12:59:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:14 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 0x7f85942dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', '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 12:59:14 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 12:59:14 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 12:59:14 INFO - Using env: {'DISPLAY': ':0', 12:59:14 INFO - 'HOME': '/home/cltbld', 12:59:14 INFO - 'LANG': 'en_US.UTF-8', 12:59:14 INFO - 'LANGUAGE': 'en_US:en', 12:59:14 INFO - 'LOGNAME': 'cltbld', 12:59:14 INFO - 'MAIL': '/var/mail/cltbld', 12:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:14 INFO - 'MOZ_NO_REMOTE': '1', 12:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:14 INFO - 'NO_EM_RESTART': '1', 12:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:14 INFO - 'PWD': '/builds/slave/test', 12:59:14 INFO - 'SHELL': '/bin/bash', 12:59:14 INFO - 'SHLVL': '1', 12:59:14 INFO - 'TERM': 'linux', 12:59:14 INFO - 'TMOUT': '86400', 12:59:14 INFO - 'USER': 'cltbld', 12:59:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', 12:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:14 INFO - '_': '/tools/buildbot/bin/python'} 12:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:14 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)) 12:59:14 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)) 12:59:14 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)) 12:59:14 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)) 12:59:14 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)) 12:59:14 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)) 12:59:14 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)) 12:59:14 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)) 12:59:14 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)) 12:59:14 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)) 12:59:14 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)) 12:59:14 INFO - Cleaning up... 12:59:14 INFO - Return code: 0 12:59:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85942dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', '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 12:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:59:14 INFO - Using env: {'DISPLAY': ':0', 12:59:14 INFO - 'HOME': '/home/cltbld', 12:59:14 INFO - 'LANG': 'en_US.UTF-8', 12:59:14 INFO - 'LANGUAGE': 'en_US:en', 12:59:14 INFO - 'LOGNAME': 'cltbld', 12:59:14 INFO - 'MAIL': '/var/mail/cltbld', 12:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:14 INFO - 'MOZ_NO_REMOTE': '1', 12:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:14 INFO - 'NO_EM_RESTART': '1', 12:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:14 INFO - 'PWD': '/builds/slave/test', 12:59:14 INFO - 'SHELL': '/bin/bash', 12:59:14 INFO - 'SHLVL': '1', 12:59:14 INFO - 'TERM': 'linux', 12:59:14 INFO - 'TMOUT': '86400', 12:59:14 INFO - 'USER': 'cltbld', 12:59:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', 12:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:14 INFO - '_': '/tools/buildbot/bin/python'} 12:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:14 INFO - Downloading/unpacking jsonschema 12:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:59:16 INFO - Downloading/unpacking functools32 (from jsonschema) 12:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:16 INFO - Downloading functools32-3.2.3-2.tar.gz 12:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:59:17 INFO - warning: no files found matching '*.txt' 12:59:17 INFO - no previously-included directories found matching 'build' 12:59:17 INFO - no previously-included directories found matching 'dist' 12:59:17 INFO - no previously-included directories found matching '.git*' 12:59:17 INFO - Installing collected packages: jsonschema, functools32 12:59:17 INFO - Running setup.py install for functools32 12:59:17 INFO - warning: no files found matching '*.txt' 12:59:17 INFO - no previously-included directories found matching 'build' 12:59:17 INFO - no previously-included directories found matching 'dist' 12:59:17 INFO - no previously-included directories found matching '.git*' 12:59:17 INFO - Successfully installed jsonschema functools32 12:59:17 INFO - Cleaning up... 12:59:17 INFO - Return code: 0 12:59:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:17 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 0x7f85942dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', '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 12:59:17 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 12:59:17 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 12:59:17 INFO - Using env: {'DISPLAY': ':0', 12:59:17 INFO - 'HOME': '/home/cltbld', 12:59:17 INFO - 'LANG': 'en_US.UTF-8', 12:59:17 INFO - 'LANGUAGE': 'en_US:en', 12:59:17 INFO - 'LOGNAME': 'cltbld', 12:59:17 INFO - 'MAIL': '/var/mail/cltbld', 12:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:17 INFO - 'MOZ_NO_REMOTE': '1', 12:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:17 INFO - 'NO_EM_RESTART': '1', 12:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:17 INFO - 'PWD': '/builds/slave/test', 12:59:17 INFO - 'SHELL': '/bin/bash', 12:59:17 INFO - 'SHLVL': '1', 12:59:17 INFO - 'TERM': 'linux', 12:59:17 INFO - 'TMOUT': '86400', 12:59:17 INFO - 'USER': 'cltbld', 12:59:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', 12:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:17 INFO - '_': '/tools/buildbot/bin/python'} 12:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:17 INFO - Downloading/unpacking flake8 12:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:59:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:59:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 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 12:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:59:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:59:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:59:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:59:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:59:20 INFO - no previously-included directories found matching 'docs/_build' 12:59:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:59:20 INFO - Running setup.py install for pep8 12:59:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:59:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:59:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:59:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:59:20 INFO - no previously-included directories found matching 'docs/_build' 12:59:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:59:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:59:20 INFO - Cleaning up... 12:59:20 INFO - Return code: 0 12:59:20 INFO - Running post-action listener: _resource_record_post_action 12:59:20 INFO - Running post-action listener: _start_resource_monitoring 12:59:20 INFO - Starting resource monitoring. 12:59:20 INFO - ##### 12:59:20 INFO - ##### Running install step. 12:59:20 INFO - ##### 12:59:20 INFO - Running pre-action listener: _resource_record_pre_action 12:59:20 INFO - Running main action method: install 12:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:59:20 INFO - Reading from file tmpfile_stdout 12:59:20 INFO - Detecting whether we're running mozinstall >=1.0... 12:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:59:20 INFO - Reading from file tmpfile_stdout 12:59:20 INFO - Output received: 12:59:20 INFO - Usage: mozinstall [options] installer 12:59:20 INFO - Options: 12:59:20 INFO - -h, --help show this help message and exit 12:59:20 INFO - -d DEST, --destination=DEST 12:59:20 INFO - Directory to install application into. [default: 12:59:20 INFO - "/builds/slave/test"] 12:59:20 INFO - --app=APP Application being installed. [default: firefox] 12:59:20 INFO - mkdir: /builds/slave/test/build/application 12:59:20 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'] 12:59:20 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 12:59:36 INFO - Reading from file tmpfile_stdout 12:59:36 INFO - Output received: 12:59:36 INFO - /builds/slave/test/build/application/firefox/firefox 12:59:36 INFO - Running post-action listener: _resource_record_post_action 12:59:36 INFO - ##### 12:59:36 INFO - ##### Running run-tests step. 12:59:36 INFO - ##### 12:59:36 INFO - Running pre-action listener: _resource_record_pre_action 12:59:36 INFO - Running main action method: run_tests 12:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:59:36 INFO - Python 2.7.3 12:59:36 INFO - Return code: 0 12:59:36 INFO - grabbing minidump binary from tooltool 12:59:36 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')]} 12:59:36 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 0x2b39410>, '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 0x2b3a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b3a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:59:36 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 12:59:36 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 12:59:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:59:36 INFO - Return code: 0 12:59:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:59:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:59:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:59:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:59:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:59:37 INFO - Return code: 0 12:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 12:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 12:59:37 INFO - Using env: {'DISPLAY': ':0', 12:59:37 INFO - 'HOME': '/home/cltbld', 12:59:37 INFO - 'LANG': 'en_US.UTF-8', 12:59:37 INFO - 'LANGUAGE': 'en_US:en', 12:59:37 INFO - 'LOGNAME': 'cltbld', 12:59:37 INFO - 'MAIL': '/var/mail/cltbld', 12:59:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:59:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:37 INFO - 'MOZ_NO_REMOTE': '1', 12:59:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:37 INFO - 'NO_EM_RESTART': '1', 12:59:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:37 INFO - 'PWD': '/builds/slave/test', 12:59:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:59:37 INFO - 'SHELL': '/bin/bash', 12:59:37 INFO - 'SHLVL': '1', 12:59:37 INFO - 'TERM': 'linux', 12:59:37 INFO - 'TMOUT': '86400', 12:59:37 INFO - 'USER': 'cltbld', 12:59:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277', 12:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:37 INFO - '_': '/tools/buildbot/bin/python'} 12:59:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 12:59:37 INFO - mozversion application_buildid: 20160325114532 12:59:37 INFO - mozversion application_changeset: fe11700b6cdfdb0fca3a9b2a54bf6d339792df24 12:59:37 INFO - mozversion application_display_name: Nightly 12:59:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:59:37 INFO - mozversion application_name: Firefox 12:59:37 INFO - mozversion application_remotingname: firefox 12:59:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:59:37 INFO - mozversion application_vendor: Mozilla 12:59:37 INFO - mozversion application_version: 48.0a1 12:59:37 INFO - mozversion platform_buildid: 20160325114532 12:59:37 INFO - mozversion platform_changeset: fe11700b6cdfdb0fca3a9b2a54bf6d339792df24 12:59:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:59:37 INFO - mozversion platform_version: 48.0a1 12:59:37 INFO - using testdate: 1458935977 12:59:37 INFO - actual date: 1458935977 12:59:37 INFO - starting webserver on 'localhost:37459' 12:59:37 INFO - SUITE-START | Running 2 tests 12:59:37 INFO - TEST-START | dromaeo_css 12:59:37 INFO - operating with platform_type : linux_ 12:59:37 INFO - Initialising browser for dromaeo_css test... 12:59:37 INFO - TEST-INFO | started process 712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVw5GE4/profile http://localhost:37459/getInfo.html) 12:59:43 INFO - PROCESS | 712 | __metrics Screen width/height:1600/1200 12:59:43 INFO - PROCESS | 712 | colorDepth:24 12:59:43 INFO - PROCESS | 712 | Browser inner width/height: 1024/697 12:59:43 INFO - PROCESS | 712 | __metrics 12:59:45 ERROR - PROCESS | 712 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:59:46 INFO - TEST-INFO | 712: exit 0 12:59:46 INFO - Browser initialized. 12:59:46 INFO - Running cycle 1/1 for dromaeo_css test... 12:59:46 INFO - TEST-INFO | started process 809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVw5GE4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:58 INFO - PROCESS | 809 | RSS: Main: 155193344 12:59:58 INFO - PROCESS | 809 | 13:00:49 INFO - PROCESS | 809 | 1458936049494 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] 13:03:01 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:37459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37459/tests/dromaeo/cssquery-ext.html) 13:03:02 INFO - PROCESS | 809 | RSS: Main: 226811904 13:03:02 INFO - PROCESS | 809 | 13:06:05 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:37459/tests/dromaeo/cssquery-ext.html (next: http://localhost:37459/tests/dromaeo/cssquery-jquery.html) 13:06:05 INFO - PROCESS | 809 | RSS: Main: 235823104 13:06:05 INFO - PROCESS | 809 | 13:09:07 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:37459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37459/tests/dromaeo/cssquery-mootools.html) 13:09:08 INFO - PROCESS | 809 | RSS: Main: 237056000 13:09:08 INFO - PROCESS | 809 | 13:12:10 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:37459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37459/tests/dromaeo/cssquery-prototype.html) 13:12:10 INFO - PROCESS | 809 | RSS: Main: 207110144 13:12:10 INFO - PROCESS | 809 | 13:15:13 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:37459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37459/tests/dromaeo/cssquery-yui.html) 13:15:13 INFO - PROCESS | 809 | RSS: Main: 198828032 13:15:13 INFO - PROCESS | 809 | 13:18:16 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:37459/tests/dromaeo/cssquery-yui.html (next: http://localhost:37459/tests/dromaeo/cssquery-dojo.html) 13:18:16 INFO - PROCESS | 809 | RSS: Main: 271962112 13:18:16 INFO - PROCESS | 809 | 13:18:16 INFO - PROCESS | 809 | __start_tp_report 13:18:16 INFO - PROCESS | 809 | _x_x_mozilla_page_load 13:18:16 INFO - PROCESS | 809 | _x_x_mozilla_page_load_details 13:18:16 INFO - PROCESS | 809 | |i|pagename|runs| 13:18:16 INFO - PROCESS | 809 | |0;dojo.html;2636.7890568754497;2725.577535482;2734.2617493276803;2738.6713594368666;2761.9309517262072;4637.814487420499;4731.455882573505;4732.006278681481;4734.147853386389;4741.90516189676;4700.506446823077;4729.59798417135;4731.550502702238;4795.520447955203;4800.663953523254;4321.373400856882;4322.1571793500125;4358.302671572549;4382.496012958502;4469.664775141861;4399.802008909607;4425.977870110645;4427.1367083418745;4479.148961697283;4481.395011673431;4213.073123912734;4313.374560688714;4314.309710446345;4373.278409062501;4379.802908869093;4331.198728235255;4341.3487976803735;4381;4388.429504164438;4400.691951563392;4309.332053531708;4316.719413238161;4316.784160791948;4330.480342358906;4349.891252718676;4529.433820772403;4577.793999270041;4590.885227869297;4649.163150632885;4656.348111264426;5031.4465408805;5034.723090230036;5034.924476132861;5038.5969122470115;5082.161443361841;5054.696718196883;5055.51972562606;5057.8229761958155;5073.036123136629;5094.59243260542;4603.49361570227;4701.106789709944;4722.079194557063;4772.0694464579765;4778.187708089633;5178.922316165261;5193;5204.947950520446;5215.947840521622;5216.791328346823;5000.2499625056535;5002.249662550574;5007.198848184273;5008.84973450797;5036.093503169464;4934.753262336869;5020.924686129711;5060.949390506122;5104.336436263262;5115.693058416507;4943.950560494421;4971.975140124277;4973.52751488608;4975.751212439363;5025.346704928409;4860.73265970368;4962.057209130254;4963;4972.627052970969;5013.022460620144;4244.0663054128045;4260.382244574581;4266.4240327556;4321.984333681582;4323.156984388014;3733.8133093345223;3762.473253744478;3767.698584113264;3802.258559580855;3809.8095095245126;4375.496817865923;4388.166248412791;4388.846390376385;4389.714668546534;4429.557044295545;4939.431965324034;4988.451270360258;5035.320231768737;5069.543741063322;5086.54221120101;4326.870193894189;4331.913361732748;4339.218940590661;4342.1749867525705;4382.846600368972;4470.284754439339;4505.549445055468;4516.209663308908;4528.388667529841;4544.954550454519;4748.0978614063215;4794.065157294294;4818.807247710192;4828.95171048285;4833.564979151894;5007.774650140679;5063.822766203165;5064.645474816727;5065.594752419871;5118.257852611276;4653.162430762495;4775.116603428377;4794.232922732346;4804.615630749462;4835.178019736582;4944.332515110558;4954.1825598775795;4977.576905963034;5014.623903207201;5022.397312322545;5031.874203144951;5034.219695947134;5035.194368900959;5042.4705405931845;5086.872828179326;4797.40032495938;4852.975735121302;4879.146149423907;4885.828995985124;4932.186189278729;4881.29221262922;4899.167141585867;4900.803967841246;4908.067467181224;4942.283368911416;4818.301346304696;4823.059503396944;4825.662203645711;4838.7338696370625;4874.926876096933;4872.4153101628035;4932.062908047459;4961.627877909099;4975.6019518437715;5008.57427118699;4806.4953179917;4809.0862736080035;4809.326694262876;4814.518548145157;4827.42070951488 13:18:16 INFO - PROCESS | 809 | |1;ext.html;542.9077056900327;546.0962107711739;563.1637019026746;575.7409165875355;592.0734051209854;29511;34137.317253654976;34184.31631367371;34308.828455857714;34315.31369372617;37583.81208093963;37892;37921.81039094808;38199.809000954956;38238.80880595593;7623.237676232374;7907.960460197691;7909.050913890341;7912.446128770988;7912.564808935506;7704.537727736326;7816;7834.686612535492;7838.960805195966;7840.882386764203;7805.102413222467;7808.80477988052;7826.843463130763;7870.370370370357;7875.645595948167;7742.109657389416;7747.883781743279;7756.457048006641;7812.648430820626;7813.76558703237;7643.46495745298;7806.960965195194;7810.765677029698;7811.609419529001;7814.140444551095;37180.814095929345;37679.24641507182;37817.43273850894;37876.43185352222;37879.62120378816;3108.347247078116;3175.285560748836;3178.55500229968;3183.283761153745;3253.3493301339827;28538;28729.85635071832;29516.70483295161;29665.258368540744;30384.088477345715;3501.4222653262436;3531.187826799825;3550.3964326064374;3569.8929032129076;3614.6566076222716;229230.85384573138;230109.9999999983;230127;230204;230511;55268;55989.72005139948;56018;56021.1596826048;56032.439675603535;62713.37286627075;63905.04142437867;64051.679741601925;64078.35921640817;64113.67943160348;13583;13759.862401375858;13779.448822047207;13791.379387927567;13814.240216787972;9764.609415623438;9796.26528010402;9798.31411801167;9814.411135331902;9822.214222862154;19364.903175484313;19393.806061939482;19450.416487505398;19460;20357.592848142955;7366.152892417441;7429.145648250413;7485.588292643957;7520.984667069875;7554.169041405441;895.5164211325811;907.4736652741394;961.2646325560952;976.6923419122953;999.7950420163849;25572.616410753853;26830.5975410369;27196.32009199786;27203.591946120825;27308.726912731017;872.4634349874781;956.799072194833;994.8656931314325;1020.5866624017285;1021.9846702299471;12900.35498225085;13398.464061437628;13419.194848308938;13541.390637421142;13583.932080339535;267696;271675;272272;272761;273156;47010.294845577344;48283.517164828605;48386.51613483891;48399.5160048402;48439.5156048435;1043.6868939318174;1203.18784820246;1210.431097384228;1235.4563991843381;1249.4127759952808;25896.61155082713;26924.596131057657;26998.190054298404;27653.30866728348;27736.86131569329;37468.43797342988;38056;38181.618183818915;38182.23635527329;38191.61808381881;205819;210819;211133;211616;211815;27263.591046133926;30984.691890596663;31668.208294792814;31825.522617161223;31950.520742188422;36606.267874642894;38256.42615360828;38796;41854.79072604617;42316.36525452059;35228.47157292694;35298;35366;35504.28991420209;36035;35605.1098722534;35900.82049589735;36084.81957590195;36235.818820905726;36304.63695363013;35241.118972025906;35430;35515.39829496693;35545.28909421849;35744.28511429809;30889;32185.517217241293;32345.838270808494;32480;32506.83746581252;22206.55586888221;22488.43778905475;22559.88720056389;25043.74956250414;26204.344891377867 13:18:16 INFO - PROCESS | 809 | |2;jquery.html;341.53210102160045;356.07420706163975;356.53828292361396;358.6216541548665;366.6938106680921;15290.464833730808;15830;16337.18314084297;16863.747043794323;16910.323587056533;10379.948100259488;10490.16078713703;10801;10823.134149268059;10827.458627068654;4492.865214043584;4659.767011649421;4665.790039448233;4674.929876051862;4684.953150468486;3500.7199424046016;5135.614828887829;5371.4897084776885;5373.973130134344;5377.569794416457;5350.5452036576935;5356.089464790975;5356.651817631841;5364.463553644624;5375.543078838304;5351.892962140755;5698.51562617178;5877.382874798127;5880.441358070976;5881.617694849842;5158.993996170748;5178.171492561172;5190.792368305263;5221.582273418117;5224.033553792523;12276.693082672915;12295.508179672803;12296.877031229662;12299.815502767466;14661.41354345825;1800.297883825309;1832.221305944968;1908.8568357373254;2072.5544008038346;2472.814538909571;8876.911230887674;8967.506787126706;9200.401973871676;9233.53832308382;9315.534223288876;1716.7081596128564;1805.5937414081857;1826.725991101332;1830.3319288459616;1836.274671504748;56899;58823.58822088573;59447.70276148592;60870;62122.99999999955;9387.249020078378;9644.614215431444;9700;9816.08586325674;9898.455584942752;12995.415206315738;13239.139455935334;13254.933725331312;13310.401031953585;13313.068085233941;6700.363465470772;6850.828729281709;6884.173899132036;6911.3779759821855;7020.543664661781;6424.51816113784;6452.387023232785;6464.644444555594;6512.804615861532;6535.183102112236;4193.475815523059;4224.577542245751;4238.915221695549;4248.086661367821;4319.827206911751;1602.87978401618;1741.7213245880598;1746.6943284925087;1763.153686230591;1833.402931058484;859.5186695450568;869.1742844297942;882.5454890731279;939.8261321655516;958.5399008475971;15851.762223566655;16045.358185672676;16159.757603635955;16380.508584742476;16725.247363868653;845.564534264854;882.9558522073999;904.2810965282616;958;973.425678849468;7262;9172.6789562365;9309.208717258973;9445.669401570913;9461.337706360626;277684;284780;285731;287322;389131;42006.579934200876;43100.78449607732;45283.54716452793;45720;57118;967.8161149381594;984.1241295247236;993.0913214408879;1004.0461561516588;1015.0357160697367;14706.926465367605;14816.332445519492;15071.09573425598;15109.168995704902;15261.160636165117;31283.905063322676;32048.839755801073;32362.190945225615;33074.66925330812;33204.50193247152;44663.77668111639;45119.54880451285;45419.31871022003;45505;45869;7406.740764073232;7409.703611855681;7538.736144234926;7620.8475830484185;7738.419618528746;10550.419726914786;11183.496742646763;11566.190366674253;11703.590374336858;11890;10035.899641003496;10304.639337623148;10308.948455257676;10502.579896804042;10679.359238445719;10078.79842403133;10183.796324073624;10187.796244075225;10305.845412318971;10361.222908281758;10233.488325583543;10824.56701731922;10868.67393978182;10909.18181136402;10984.615538456115;7638.541687498768;7661.923380766121;7715.344195743424;7727;7768.339691126317;10413.11488523484;10478.94760526223;10511.106555942524;10559.524821382902;10792.946035269773 13:18:16 INFO - PROCESS | 809 | |3;mootools.html;1250.1561446023932;1441.7909403136546;1448.0587618048266;1598.5763772600255;1752.815954324795;7301.6714247858845;7460.925390746091;7481.251874812516;7488.812779680504;7501.174870764212;7066.222715501291;7212.819679508002;7214.278572142783;7225.927740722591;7227.855442891139;1941.3302410668298;1986.7814540400545;1988.1848442138726;2239.8320125990535;2270.5118399544094;2228.721409823772;2288.9542209155807;2289.5878741826464;2290.3129061281547;2291.346966114658;2197.252934002439;2207.624703800358;2207.6688496725537;2210.082815631511;2315.9536809263805;2240.5070884405404;2247.8763667998255;2249.4488850231714;2252.087904398721;2254.2448279826276;2159.2334721173916;2173.3479956013134;2177.194438057913;2192.0683709423433;2199.48312146647;7606.923930760732;7626.885596716053;7653.617319134021;7672.117706463772;7683.193264707237;4486.865394038184;4573.542645735433;4605.125026245003;4613.238815595423;4635.9536404635855;3067.417190733776;3167.160702413862;3192.074298453446;3196.6323872754697;3200.18395309197;1032.2619327181026;1043.212374657129;1066.3921564708119;1069.3316677076828;1109.983350249747;10218.437985910847;10251;10271;10290.228232882564;10298.330608510498;4233.767142807175;4269.573042695768;4392.209402307615;4394.714343567658;4396;8635.956820215984;8647.394682372174;8654.524001179869;8673.35206310799;8682.52246126469;4745.193317136095;4778.904421911542;4779.498152693986;4784.4497882743235;4786.617070634341;3746.38184699527;4160.791960401968;4299.527052024275;4300.440942677495;4310.267254566731;3652.634736526326;3679.2089700714473;3711.5731690855896;3720.813959302024;3737.4580685800406;1212.0727643352843;1217.3852204636603;1222.095649219589;1234.7653945750278;1242.2360248447321;1175.2302242031483;1177.3053898200103;1203.9939800301117;1204.8373469581495;1221.096388672376;7181.748638797617;7250.057492525938;7278.745243916437;7300.671469783872;7315.670794814246;452.81887245102223;462.5212904643678;464.4357106116085;464.5540281329961;469.5633061253067;5378.51593356592;5385.676859388371;5391.514763671288;5393.7572809223675;5443;8922.375433719708;9042.457452552868;9327.766805829908;9331.673391431268;9338.766530836783;9042.909570904207;9105.726828195166;9127.680531181377;9215.216706579882;9222.677206297747;6807.65961701913;6812.761553345609;6889.311068893171;7210.062691850026;7234.348908598146;6829.2487826338065;6884.965575172092;6891.965540172267;6911.861762764616;6928.4803639726215;8128.593570321578;8179.427440079137;8276.627551760306;8301.501909885426;8313.210245026712;8316;8461.873071903803;8531.95734021326;8579.785505362415;8627.611757470804;6596.8350791230605;6627.237867645283;6630.436412904764;6662.866742665216;6666.2333831609985;7112.182099058675;7147.928520714726;7151.642417878981;7153.070100886852;7215.422766178798;6178.69106544662;6317.305096439296;6385.840353991188;6437.581557198767;6515.934840651533;6367.363263673596;6466.32103629131;6577.572457790228;6582.3746744059235;6687.8328041797395;6645.069690243273;6671.833204169935;6687.531872768859;6698.83252918681;6724.72230276246;6109.358517355614;6208.937910620836;6249.437550620466;6279.058141278845;6280.183576135073;6229.2524897012645;6237.12680224778;6284.151639528788;6293.307736149111;6305.464035557029 13:18:16 INFO - PROCESS | 809 | |4;prototype.html;317.4634867074642;317.7251677299137;317.7854947910163;320.2058893943021;325.14162610707734;5215.374155101384;5305.549028332592;5320.536852365606;5325.520703136717;5328.094223981922;5217.530422261995;5222.660527065738;5243.187305967572;5250.264962905197;5250.317458730369;3905.7070719696135;3993.6206060424215;4066.329055705805;4132.400801883732;4139.089400331922;4074.9185016299803;4102.261592913274;4104.179164167163;4104.466419365478;4113.362428823522;4045.9480535060948;4062.5124985001694;4065.125997910449;4070.87787366378;4083.775392353419;3899.8245078971513;3966.4248683940955;3968.523777146732;3986.7009974252046;4082.122343696105;3563.2695297463956;3574.3744844652083;3580.3555360035184;3585.0858031202138;3587.157018100744;5024.949750502485;5035.3454050973505;5036.370453693288;5040.672356296829;5047.141985862412;4700.976495117503;4706.1999460091865;4707.223308154151;4707.905841883143;4717.882052948669;5505.889882202374;5520.475554822286;5527.834164975057;5529;5531.668099914018;3911.2959667259884;3930.8231129599235;3932.6067393260446;3933.724639275252;3939.98030009851;5610.24261724666;5802.274715660543;5815.9531284368795;5829.854253643651;5850.414958504116;3940.054386947112;3946.6842652587725;3961.6632586229916;3962.7424217425773;3967.1867267210155;4004.419359192959;4005.599440055971;4006.1186538961965;4009.278329900588;4014.5182578090817;4612.238980568236;4614.192516309699;4617.422822147231;4625.537446255347;4628;5522.530584900248;5536.169574563848;5536.695481748542;5542.722863856791;5551.528120109755;1389.4858902206047;1402.5441731437325;1407.3174510362671;1409.7251036048078;1413.7455258053444;923.4736200365727;929.702495201529;934.2855859497762;936.0873148679982;953.0993211415284;4713.175194340976;4790.4251489820745;4845.8546243612045;4881.414230292387;4894.3147959285725;5739.971300143473;5743.770249190069;5749.568782341341;5750.079987202112;5771.365149833515;4879.804807807719;4882.829100981519;4888.877778055577;4889.119958407449;4890;3047.7866549341334;3085.6451508076857;3103.572356715936;3104.62744470665;3113.6263648361887;5474.589405794582;5482.424345443751;5484.698341591171;5486.753096110685;5486.807961721321;5747.770089196385;5870.090136028923;5901.940980590225;5927.1405646181065;5931.110333450017;5430.945690543044;5450.29146210998;5454.290942177491;5454.3454785426;5463.699496527729;5763.481286684051;5771.884562308815;5774.595778295479;5778.219940308173;5779.566532510163;5640.294963129609;5645.322561292671;5648.039833228278;5650.124230744241;5654.6324488908085;5467.152591348347;5469.75386107634;5470.343558772973;5472.288602481652;5477.014137455137;3868.3037053330672;3976.721629485908;3978.085040440657;3982.38273067675;3984.5019372578427;5720.656760594377;5733.598648094593;5743.62666426681;5747.195392645117;5747.3103227612955;5554.75003624846;5560.694161821139;5563.13771365439;5567.66594004361;5568.832935011957;5558.194061861089;5561.888762224814;5563.193336966198;5570.944290557205;5573.6098473106495;5457.61796674229;5477.370102438271;5477.397486276586;5480.561555075664;5482.835514934558;5442.619016668795;5554.722263886871;5580.135079062752;5582.106862901916;5586.832395028156;5432.565394768488;5447.727613619224;5454.645448045864;5466.262054622575;5472.042392581203 13:18:16 INFO - PROCESS | 809 | |5;yui.html;658.6937074260468;719.5502810743285;733.5048842031628;779.3180966654178;797.7646594254694;11694.883051169485;14329;14361.92819035906;14383;14451.566453006426;13311.334433278345;13384.330783460837;13488.190708557493;13502.12236204646;13548.254845983467;655.2890114226046;809.4172196018857;810.2221867007651;825.4180802534199;826.0294154368623;830.6469750356105;831.3723139030024;831.629924683516;831.6714897615439;833.1418638802044;859.9699010534632;870.4342177584557;871.6905498548019;872.0494660819705;872.0668884293808;686.4062585863243;842.7387509871959;856.4989481153533;862.8835107260502;863.0980625246601;623.3984205241918;625.7027911741932;626.3110578363809;626.4737620398841;627.491731697322;12590.74818503634;12636.49454021838;12715.491380344774;12739.36303184837;12750.171238869443;11626.244294120856;12285.324307163102;12488.313142777144;12615.936920315431;12688.17526860751;9579.808403831954;9673.613055477772;9692;9860.852087218625;10010;3270.084376374619;3273.8035717857006;3347.73218142548;3376.3247350529746;3380.256343604403;44344;44423.555764442266;44441.333379999;44476;44590;9794.902050979399;9889.357191782656;9896.802063958681;10068.44623545712;10142.137918276881;16967.236474358684;16968.49094527166;16975;17011.23449444778;17032.2335494903;6489.805305840832;6630.1049358336;6708.228553716288;6711.630860302633;6836.4530837532875;2886.307286251327;3554.862444017941;3742.9438558421643;3781.1870447853844;3798.0884587699306;2932.0470846974818;2951.985240073786;2969.584258203853;2971.524556071018;2973.405318936221;500.7846625950803;518.5410911343413;518.7095226673075;590.8493334199752;610.3926593039865;552.4806681719172;636.920384951881;646.6281887914467;648.3678413546849;675.2470994840717;8130.146334634778;8477.660893564189;8573.314134869195;8619.784505387415;8647.178518040777;551.7186235020089;642.081822993115;642.097852517214;653.4119292636665;657.6021506988203;3761.567419746709;3796.620337966181;3939.6060393960947;3988.8404463821703;4012.2814836824873;51672.22491662628;52854.735726321895;52867.20699189515;52911;52913.206301905506;43393.78303108464;44402;44763.77618111888;44895;45016.54983450124;41304.586954130675;41550;41776.99999999939;42032.57967420348;42127.36808947868;7706;7765.1846556110795;7779;7833.49082309648;7965.163657815846;30743.69256307498;31196.376072478877;31447.84276078605;32317.676823231468;33081.50377744384;35346.46980295349;35994.46008309825;36150;36323.547058118435;36755.63244367629;10608.151347892304;10896.564137434414;10998.34009959405;11228.55085796559;11507.769844603228;11752.353620550952;12012.279263244232;12308.753824923273;12312.445939932904;12347.69130771702;11295.152863535104;11587.8261826071;11717.941410292893;11898.464569094585;12101.031917446408;11514.30914145154;11631.709207269547;12144;12145.69635759113;12157.513699451923;11383.829242561535;11689.824652630048;11795.29228246308;12042.939785301018;12076.154669173073;9500.762480938032;9544.369732920077;9563.378380405251;9628.277879159232;10126.746831329276;9696.95151524238;10003.749906252402;10083.294169408364;10084.495775211064;10094.545745441326 13:18:16 INFO - PROCESS | 809 | __end_tp_report 13:18:16 INFO - PROCESS | 809 | __start_cc_report 13:18:16 INFO - PROCESS | 809 | _x_x_mozilla_cycle_collect,941 13:18:16 INFO - PROCESS | 809 | __end_cc_report 13:18:16 INFO - PROCESS | 809 | __startTimestamp1458937096973__endTimestamp 13:18:16 INFO - PROCESS | 809 | 13:18:16 INFO - PROCESS | 809 | ------- Summary: start ------- 13:18:16 INFO - PROCESS | 809 | Number of tests: 6 13:18:16 INFO - PROCESS | 809 | 13:18:16 INFO - PROCESS | 809 | [#0] dojo.html Cycles:165 Average:4667.02 Median:4806.50 stddev:471.24 (9.8%) stddev-sans-first:444.96 13:18:16 INFO - PROCESS | 809 | Values: 2636.8 2725.6 2734.3 2738.7 2761.9 4637.8 4731.5 4732.0 4734.1 4741.9 4700.5 4729.6 4731.6 4795.5 4800.7 4321.4 4322.2 4358.3 4382.5 4469.7 4399.8 4426.0 4427.1 4479.1 4481.4 4213.1 4313.4 4314.3 4373.3 4379.8 4331.2 4341.3 4381.0 4388.4 4400.7 4309.3 4316.7 4316.8 4330.5 4349.9 4529.4 4577.8 4590.9 4649.2 4656.3 5031.4 5034.7 5034.9 5038.6 5082.2 5054.7 5055.5 5057.8 5073.0 5094.6 4603.5 4701.1 4722.1 4772.1 4778.2 5178.9 5193.0 5204.9 5215.9 5216.8 5000.2 5002.2 5007.2 5008.8 5036.1 4934.8 5020.9 5060.9 5104.3 5115.7 4944.0 4972.0 4973.5 4975.8 5025.3 4860.7 4962.1 4963.0 4972.6 5013.0 4244.1 4260.4 4266.4 4322.0 4323.2 3733.8 3762.5 3767.7 3802.3 3809.8 4375.5 4388.2 4388.8 4389.7 4429.6 4939.4 4988.5 5035.3 5069.5 5086.5 4326.9 4331.9 4339.2 4342.2 4382.8 4470.3 4505.5 4516.2 4528.4 4545.0 4748.1 4794.1 4818.8 4829.0 4833.6 5007.8 5063.8 5064.6 5065.6 5118.3 4653.2 4775.1 4794.2 4804.6 4835.2 4944.3 4954.2 4977.6 5014.6 5022.4 5031.9 5034.2 5035.2 5042.5 5086.9 4797.4 4853.0 4879.1 4885.8 4932.2 4881.3 4899.2 4900.8 4908.1 4942.3 4818.3 4823.1 4825.7 4838.7 4874.9 4872.4 4932.1 4961.6 4975.6 5008.6 4806.5 4809.1 4809.3 4814.5 4827.4 13:18:16 INFO - PROCESS | 809 | 13:18:16 INFO - PROCESS | 809 | [#1] ext.html Cycles:180 Average:40451.79 Median:35822.55 stddev:62162.64 (173.5%) stddev-sans-first:62264.79 13:18:16 INFO - PROCESS | 809 | Values: 542.9 546.1 563.2 575.7 592.1 29511.0 34137.3 34184.3 34308.8 34315.3 37583.8 37892.0 37921.8 38199.8 38238.8 7623.2 7908.0 7909.1 7912.4 7912.6 7704.5 7816.0 7834.7 7839.0 7840.9 7805.1 7808.8 7826.8 7870.4 7875.6 7742.1 7747.9 7756.5 7812.6 7813.8 7643.5 7807.0 7810.8 7811.6 7814.1 37180.8 37679.2 37817.4 37876.4 37879.6 3108.3 3175.3 3178.6 3183.3 3253.3 28538.0 28729.9 29516.7 29665.3 30384.1 3501.4 3531.2 3550.4 3569.9 3614.7 229230.9 230110.0 230127.0 230204.0 230511.0 55268.0 55989.7 56018.0 56021.2 56032.4 62713.4 63905.0 64051.7 64078.4 64113.7 13583.0 13759.9 13779.4 13791.4 13814.2 9764.6 9796.3 9798.3 9814.4 9822.2 19364.9 19393.8 19450.4 19460.0 20357.6 7366.2 7429.1 7485.6 7521.0 7554.2 895.5 907.5 961.3 976.7 999.8 25572.6 26830.6 27196.3 27203.6 27308.7 872.5 956.8 994.9 1020.6 1022.0 12900.4 13398.5 13419.2 13541.4 13583.9 267696.0 271675.0 272272.0 272761.0 273156.0 47010.3 48283.5 48386.5 48399.5 48439.5 1043.7 1203.2 1210.4 1235.5 1249.4 25896.6 26924.6 26998.2 27653.3 27736.9 37468.4 38056.0 38181.6 38182.2 38191.6 205819.0 210819.0 211133.0 211616.0 211815.0 27263.6 30984.7 31668.2 31825.5 31950.5 36606.3 38256.4 38796.0 41854.8 42316.4 35228.5 35298.0 35366.0 35504.3 36035.0 35605.1 35900.8 36084.8 36235.8 36304.6 35241.1 35430.0 35515.4 35545.3 35744.3 30889.0 32185.5 32345.8 32480.0 32506.8 22206.6 22488.4 22559.9 25043.7 26204.3 13:18:16 INFO - PROCESS | 809 | 13:18:16 INFO - PROCESS | 809 | [#2] jquery.html Cycles:180 Average:20041.91 Median:4231.75 stddev:50576.73 (1195.2%) stddev-sans-first:50696.98 13:18:16 INFO - PROCESS | 809 | Values: 341.5 356.1 356.5 358.6 366.7 15290.5 15830.0 16337.2 16863.7 16910.3 10379.9 10490.2 10801.0 10823.1 10827.5 4492.9 4659.8 4665.8 4674.9 4685.0 3500.7 5135.6 5371.5 5374.0 5377.6 5350.5 5356.1 5356.7 5364.5 5375.5 5351.9 5698.5 5877.4 5880.4 5881.6 5159.0 5178.2 5190.8 5221.6 5224.0 12276.7 12295.5 12296.9 12299.8 14661.4 1800.3 1832.2 1908.9 2072.6 2472.8 8876.9 8967.5 9200.4 9233.5 9315.5 1716.7 1805.6 1826.7 1830.3 1836.3 56899.0 58823.6 59447.7 60870.0 62123.0 9387.2 9644.6 9700.0 9816.1 9898.5 12995.4 13239.1 13254.9 13310.4 13313.1 6700.4 6850.8 6884.2 6911.4 7020.5 6424.5 6452.4 6464.6 6512.8 6535.2 4193.5 4224.6 4238.9 4248.1 4319.8 1602.9 1741.7 1746.7 1763.2 1833.4 859.5 869.2 882.5 939.8 958.5 15851.8 16045.4 16159.8 16380.5 16725.2 845.6 883.0 904.3 958.0 973.4 7262.0 9172.7 9309.2 9445.7 9461.3 277684.0 284780.0 285731.0 287322.0 389131.0 42006.6 43100.8 45283.5 45720.0 57118.0 967.8 984.1 993.1 1004.0 1015.0 14706.9 14816.3 15071.1 15109.2 15261.2 31283.9 32048.8 32362.2 33074.7 33204.5 44663.8 45119.5 45419.3 45505.0 45869.0 7406.7 7409.7 7538.7 7620.8 7738.4 10550.4 11183.5 11566.2 11703.6 11890.0 10035.9 10304.6 10308.9 10502.6 10679.4 10078.8 10183.8 10187.8 10305.8 10361.2 10233.5 10824.6 10868.7 10909.2 10984.6 7638.5 7661.9 7715.3 7727.0 7768.3 10413.1 10478.9 10511.1 10559.5 10792.9 13:18:16 INFO - PROCESS | 809 | 13:18:16 INFO - PROCESS | 809 | [#3] mootools.html Cycles:180 Average:5275.00 Median:6144.02 stddev:2730.26 (44.4%) stddev-sans-first:2721.15 13:18:16 INFO - PROCESS | 809 | Values: 1250.2 1441.8 1448.1 1598.6 1752.8 7301.7 7460.9 7481.3 7488.8 7501.2 7066.2 7212.8 7214.3 7225.9 7227.9 1941.3 1986.8 1988.2 2239.8 2270.5 2228.7 2289.0 2289.6 2290.3 2291.3 2197.3 2207.6 2207.7 2210.1 2316.0 2240.5 2247.9 2249.4 2252.1 2254.2 2159.2 2173.3 2177.2 2192.1 2199.5 7606.9 7626.9 7653.6 7672.1 7683.2 4486.9 4573.5 4605.1 4613.2 4636.0 3067.4 3167.2 3192.1 3196.6 3200.2 1032.3 1043.2 1066.4 1069.3 1110.0 10218.4 10251.0 10271.0 10290.2 10298.3 4233.8 4269.6 4392.2 4394.7 4396.0 8636.0 8647.4 8654.5 8673.4 8682.5 4745.2 4778.9 4779.5 4784.4 4786.6 3746.4 4160.8 4299.5 4300.4 4310.3 3652.6 3679.2 3711.6 3720.8 3737.5 1212.1 1217.4 1222.1 1234.8 1242.2 1175.2 1177.3 1204.0 1204.8 1221.1 7181.7 7250.1 7278.7 7300.7 7315.7 452.8 462.5 464.4 464.6 469.6 5378.5 5385.7 5391.5 5393.8 5443.0 8922.4 9042.5 9327.8 9331.7 9338.8 9042.9 9105.7 9127.7 9215.2 9222.7 6807.7 6812.8 6889.3 7210.1 7234.3 6829.2 6885.0 6892.0 6911.9 6928.5 8128.6 8179.4 8276.6 8301.5 8313.2 8316.0 8461.9 8532.0 8579.8 8627.6 6596.8 6627.2 6630.4 6662.9 6666.2 7112.2 7147.9 7151.6 7153.1 7215.4 6178.7 6317.3 6385.8 6437.6 6515.9 6367.4 6466.3 6577.6 6582.4 6687.8 6645.1 6671.8 6687.5 6698.8 6724.7 6109.4 6208.9 6249.4 6279.1 6280.2 6229.3 6237.1 6284.2 6293.3 6305.5 13:18:16 INFO - PROCESS | 809 | 13:18:16 INFO - PROCESS | 809 | [#4] prototype.html Cycles:180 Average:4600.74 Median:5277.93 stddev:1355.44 (25.7%) stddev-sans-first:1320.57 13:18:16 INFO - PROCESS | 809 | Values: 317.5 317.7 317.8 320.2 325.1 5215.4 5305.5 5320.5 5325.5 5328.1 5217.5 5222.7 5243.2 5250.3 5250.3 3905.7 3993.6 4066.3 4132.4 4139.1 4074.9 4102.3 4104.2 4104.5 4113.4 4045.9 4062.5 4065.1 4070.9 4083.8 3899.8 3966.4 3968.5 3986.7 4082.1 3563.3 3574.4 3580.4 3585.1 3587.2 5024.9 5035.3 5036.4 5040.7 5047.1 4701.0 4706.2 4707.2 4707.9 4717.9 5505.9 5520.5 5527.8 5529.0 5531.7 3911.3 3930.8 3932.6 3933.7 3940.0 5610.2 5802.3 5816.0 5829.9 5850.4 3940.1 3946.7 3961.7 3962.7 3967.2 4004.4 4005.6 4006.1 4009.3 4014.5 4612.2 4614.2 4617.4 4625.5 4628.0 5522.5 5536.2 5536.7 5542.7 5551.5 1389.5 1402.5 1407.3 1409.7 1413.7 923.5 929.7 934.3 936.1 953.1 4713.2 4790.4 4845.9 4881.4 4894.3 5740.0 5743.8 5749.6 5750.1 5771.4 4879.8 4882.8 4888.9 4889.1 4890.0 3047.8 3085.6 3103.6 3104.6 3113.6 5474.6 5482.4 5484.7 5486.8 5486.8 5747.8 5870.1 5901.9 5927.1 5931.1 5430.9 5450.3 5454.3 5454.3 5463.7 5763.5 5771.9 5774.6 5778.2 5779.6 5640.3 5645.3 5648.0 5650.1 5654.6 5467.2 5469.8 5470.3 5472.3 5477.0 3868.3 3976.7 3978.1 3982.4 3984.5 5720.7 5733.6 5743.6 5747.2 5747.3 5554.8 5560.7 5563.1 5567.7 5568.8 5558.2 5561.9 5563.2 5570.9 5573.6 5457.6 5477.4 5477.4 5480.6 5482.8 5442.6 5554.7 5580.1 5582.1 5586.8 5432.6 5447.7 5454.6 5466.3 5472.0 13:18:16 INFO - PROCESS | 809 | 13:18:16 INFO - PROCESS | 809 | [#5] yui.html Cycles:180 Average:12826.31 Median:41904.79 stddev:14127.82 (33.7%) stddev-sans-first:14137.90 13:18:16 INFO - PROCESS | 809 | Values: 658.7 719.6 733.5 779.3 797.8 11694.9 14329.0 14361.9 14383.0 14451.6 13311.3 13384.3 13488.2 13502.1 13548.3 655.3 809.4 810.2 825.4 826.0 830.6 831.4 831.6 831.7 833.1 860.0 870.4 871.7 872.0 872.1 686.4 842.7 856.5 862.9 863.1 623.4 625.7 626.3 626.5 627.5 12590.7 12636.5 12715.5 12739.4 12750.2 11626.2 12285.3 12488.3 12615.9 12688.2 9579.8 9673.6 9692.0 9860.9 10010.0 3270.1 3273.8 3347.7 3376.3 3380.3 44344.0 44423.6 44441.3 44476.0 44590.0 9794.9 9889.4 9896.8 10068.4 10142.1 16967.2 16968.5 16975.0 17011.2 17032.2 6489.8 6630.1 6708.2 6711.6 6836.5 2886.3 3554.9 3742.9 3781.2 3798.1 2932.0 2952.0 2969.6 2971.5 2973.4 500.8 518.5 518.7 590.8 610.4 552.5 636.9 646.6 648.4 675.2 8130.1 8477.7 8573.3 8619.8 8647.2 551.7 642.1 642.1 653.4 657.6 3761.6 3796.6 3939.6 3988.8 4012.3 51672.2 52854.7 52867.2 52911.0 52913.2 43393.8 44402.0 44763.8 44895.0 45016.5 41304.6 41550.0 41777.0 42032.6 42127.4 7706.0 7765.2 7779.0 7833.5 7965.2 30743.7 31196.4 31447.8 32317.7 33081.5 35346.5 35994.5 36150.0 36323.5 36755.6 10608.2 10896.6 10998.3 11228.6 11507.8 11752.4 12012.3 12308.8 12312.4 12347.7 11295.2 11587.8 11717.9 11898.5 12101.0 11514.3 11631.7 12144.0 12145.7 12157.5 11383.8 11689.8 11795.3 12042.9 12076.2 9500.8 9544.4 9563.4 9628.3 10126.7 9697.0 10003.7 10083.3 10084.5 10094.5 13:18:16 INFO - PROCESS | 809 | -------- Summary: end -------- 13:18:16 INFO - PROCESS | 809 | 13:18:17 INFO - TEST-INFO | 809: exit 0 13:18:17 INFO - TEST-OK | dromaeo_css | took 1120339ms 13:18:17 INFO - TEST-START | kraken 13:18:17 INFO - operating with platform_type : linux_ 13:18:17 INFO - Initialising browser for kraken test... 13:18:17 INFO - TEST-INFO | started process 1001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNEsf_U/profile http://localhost:37459/getInfo.html) 13:18:23 INFO - PROCESS | 1001 | __metrics Screen width/height:1600/1200 13:18:23 INFO - PROCESS | 1001 | colorDepth:24 13:18:23 INFO - PROCESS | 1001 | Browser inner width/height: 1024/697 13:18:23 INFO - PROCESS | 1001 | __metrics 13:18:24 ERROR - PROCESS | 1001 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:18:25 INFO - TEST-INFO | 1001: exit 0 13:18:25 INFO - Browser initialized. 13:18:25 INFO - Running cycle 1/1 for kraken test... 13:18:25 INFO - TEST-INFO | started process 1089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNEsf_U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:37 INFO - PROCESS | 1089 | RSS: Main: 155095040 13:18:37 INFO - PROCESS | 1089 | 13:18:40 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37459/tests/kraken/driver.html?testName=audio-beat-detection) 13:18:40 INFO - PROCESS | 1089 | RSS: Main: 195706880 13:18:40 INFO - PROCESS | 1089 | 13:18:43 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37459/tests/kraken/driver.html?testName=audio-dft) 13:18:44 INFO - PROCESS | 1089 | RSS: Main: 185565184 13:18:44 INFO - PROCESS | 1089 | 13:18:47 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37459/tests/kraken/driver.html?testName=audio-fft) 13:18:47 INFO - PROCESS | 1089 | RSS: Main: 170561536 13:18:47 INFO - PROCESS | 1089 | 13:18:49 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37459/tests/kraken/driver.html?testName=audio-oscillator) 13:18:50 INFO - PROCESS | 1089 | RSS: Main: 172236800 13:18:50 INFO - PROCESS | 1089 | 13:18:52 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:18:53 INFO - PROCESS | 1089 | RSS: Main: 174026752 13:18:53 INFO - PROCESS | 1089 | 13:18:56 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37459/tests/kraken/driver.html?testName=imaging-darkroom) 13:18:56 INFO - PROCESS | 1089 | RSS: Main: 174428160 13:18:56 INFO - PROCESS | 1089 | 13:19:00 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37459/tests/kraken/driver.html?testName=imaging-desaturate) 13:19:00 INFO - PROCESS | 1089 | RSS: Main: 175128576 13:19:00 INFO - PROCESS | 1089 | 13:19:03 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37459/tests/kraken/driver.html?testName=json-parse-financial) 13:19:04 INFO - PROCESS | 1089 | RSS: Main: 175628288 13:19:04 INFO - PROCESS | 1089 | 13:19:06 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:19:06 INFO - PROCESS | 1089 | RSS: Main: 184553472 13:19:06 INFO - PROCESS | 1089 | 13:19:08 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37459/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:19:09 INFO - PROCESS | 1089 | RSS: Main: 183214080 13:19:09 INFO - PROCESS | 1089 | 13:19:11 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:19:11 INFO - PROCESS | 1089 | RSS: Main: 195039232 13:19:11 INFO - PROCESS | 1089 | 13:19:14 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:19:14 INFO - PROCESS | 1089 | RSS: Main: 197492736 13:19:14 INFO - PROCESS | 1089 | 13:19:17 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:19:18 INFO - PROCESS | 1089 | RSS: Main: 195936256 13:19:18 INFO - PROCESS | 1089 | 13:19:19 INFO - PROCESS | 1089 | Cycle 1(1): loaded http://localhost:37459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37459/tests/kraken/driver.html?testName=ai-astar) 13:19:20 INFO - PROCESS | 1089 | RSS: Main: 258260992 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | __start_tp_report 13:19:20 INFO - PROCESS | 1089 | _x_x_mozilla_page_load 13:19:20 INFO - PROCESS | 1089 | _x_x_mozilla_page_load_details 13:19:20 INFO - PROCESS | 1089 | |i|pagename|runs| 13:19:20 INFO - PROCESS | 1089 | |0;ai-astar;111;113;107;115;115;113;101;113;111;111 13:19:20 INFO - PROCESS | 1089 | |1;audio-beat-detection;157;133;155;170;132;152;153;132;174;140 13:19:20 INFO - PROCESS | 1089 | |2;audio-dft;161;163;160;162;162;161;163;162;161;161 13:19:20 INFO - PROCESS | 1089 | |3;audio-fft;73;80;109;102;74;74;74;117;93;75 13:19:20 INFO - PROCESS | 1089 | |4;audio-oscillator;94;94;136;94;95;93;135;94;94;139 13:19:20 INFO - PROCESS | 1089 | |5;imaging-gaussian-blur;117;117;117;117;119;117;117;117;117;116 13:19:20 INFO - PROCESS | 1089 | |6;imaging-darkroom;146;146;148;145;147;146;148;146;147;146 13:19:20 INFO - PROCESS | 1089 | |7;imaging-desaturate;95;95;97;95;96;95;96;96;95;96 13:19:20 INFO - PROCESS | 1089 | |8;json-parse-financial;63;64;65;64;64;64;63;74;62;63 13:19:20 INFO - PROCESS | 1089 | |9;json-stringify-tinderbox;63;64;64;65;64;64;64;64;64;63 13:19:20 INFO - PROCESS | 1089 | |10;stanford-crypto-aes;83;82;81;83;83;81;90;81;83;81 13:19:20 INFO - PROCESS | 1089 | |11;stanford-crypto-ccm;125;120;124;115;133;118;131;124;117;134 13:19:20 INFO - PROCESS | 1089 | |12;stanford-crypto-pbkdf2;144;132;151;144;145;132;141;143;144;131 13:19:20 INFO - PROCESS | 1089 | |13;stanford-crypto-sha256-iterative;68;68;68;67;68;66;69;68;68;72 13:19:20 INFO - PROCESS | 1089 | __end_tp_report 13:19:20 INFO - PROCESS | 1089 | __start_cc_report 13:19:20 INFO - PROCESS | 1089 | _x_x_mozilla_cycle_collect,1150 13:19:20 INFO - PROCESS | 1089 | __end_cc_report 13:19:20 INFO - PROCESS | 1089 | __startTimestamp1458937160075__endTimestamp 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | ------- Summary: start ------- 13:19:20 INFO - PROCESS | 1089 | Number of tests: 14 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:4.22 (3.7%) stddev-sans-first:4.47 13:19:20 INFO - PROCESS | 1089 | Values: 111.0 113.0 107.0 115.0 115.0 113.0 101.0 113.0 111.0 111.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.00 stddev:15.27 (9.9%) stddev-sans-first:15.98 13:19:20 INFO - PROCESS | 1089 | Values: 157.0 133.0 155.0 170.0 132.0 152.0 153.0 132.0 174.0 140.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 13:19:20 INFO - PROCESS | 1089 | Values: 161.0 163.0 160.0 162.0 162.0 161.0 163.0 162.0 161.0 161.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#3] audio-fft Cycles:10 Average:87.10 Median:74.00 stddev:16.80 (22.7%) stddev-sans-first:17.03 13:19:20 INFO - PROCESS | 1089 | Values: 73.0 80.0 109.0 102.0 74.0 74.0 74.0 117.0 93.0 75.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:94.00 stddev:20.64 (22.0%) stddev-sans-first:21.36 13:19:20 INFO - PROCESS | 1089 | Values: 94.0 94.0 136.0 94.0 95.0 93.0 135.0 94.0 94.0 139.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 13:19:20 INFO - PROCESS | 1089 | Values: 117.0 117.0 117.0 117.0 119.0 117.0 117.0 117.0 117.0 116.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 13:19:20 INFO - PROCESS | 1089 | Values: 146.0 146.0 148.0 145.0 147.0 146.0 148.0 146.0 147.0 146.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 13:19:20 INFO - PROCESS | 1089 | Values: 95.0 95.0 97.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:3.41 (5.3%) stddev-sans-first:3.56 13:19:20 INFO - PROCESS | 1089 | Values: 63.0 64.0 65.0 64.0 64.0 64.0 63.0 74.0 62.0 63.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 13:19:20 INFO - PROCESS | 1089 | Values: 63.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 63.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:2.70 (3.3%) stddev-sans-first:2.86 13:19:20 INFO - PROCESS | 1089 | Values: 83.0 82.0 81.0 83.0 83.0 81.0 90.0 81.0 83.0 81.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.50 stddev:6.77 (5.4%) stddev-sans-first:7.18 13:19:20 INFO - PROCESS | 1089 | Values: 125.0 120.0 124.0 115.0 133.0 118.0 131.0 124.0 117.0 134.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:144.00 stddev:6.73 (4.7%) stddev-sans-first:7.04 13:19:20 INFO - PROCESS | 1089 | Values: 144.0 132.0 151.0 144.0 145.0 132.0 141.0 143.0 144.0 131.0 13:19:20 INFO - PROCESS | 1089 | 13:19:20 INFO - PROCESS | 1089 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.55 (2.3%) stddev-sans-first:1.64 13:19:20 INFO - PROCESS | 1089 | Values: 68.0 68.0 68.0 67.0 68.0 66.0 69.0 68.0 68.0 72.0 13:19:20 INFO - PROCESS | 1089 | -------- Summary: end -------- 13:19:20 INFO - PROCESS | 1089 | 13:19:21 INFO - TEST-INFO | 1089: exit 0 13:19:21 INFO - TEST-OK | kraken | took 63319ms 13:19:21 INFO - SUITE-END | took 1183s 13:19:21 INFO - Completed test suite (00:19:43) 13:19:21 INFO - javascript benchmark 13:19:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2636.7890568754497, 2725.577535482, 2734.2617493276803, 2738.6713594368666, 2761.9309517262072, 4637.814487420499, 4731.455882573505, 4732.006278681481, 4734.147853386389, 4741.90516189676, 4700.506446823077, 4729.59798417135, 4731.550502702238, 4795.520447955203, 4800.663953523254, 4321.373400856882, 4322.1571793500125, 4358.302671572549, 4382.496012958502, 4469.664775141861, 4399.802008909607, 4425.977870110645, 4427.1367083418745, 4479.148961697283, 4481.395011673431, 4213.073123912734, 4313.374560688714, 4314.309710446345, 4373.278409062501, 4379.802908869093, 4331.198728235255, 4341.3487976803735, 4381.0, 4388.429504164438, 4400.691951563392, 4309.332053531708, 4316.719413238161, 4316.784160791948, 4330.480342358906, 4349.891252718676, 4529.433820772403, 4577.793999270041, 4590.885227869297, 4649.163150632885, 4656.348111264426, 5031.4465408805, 5034.723090230036, 5034.924476132861, 5038.5969122470115, 5082.161443361841, 5054.696718196883, 5055.51972562606, 5057.8229761958155, 5073.036123136629, 5094.59243260542, 4603.49361570227, 4701.106789709944, 4722.079194557063, 4772.0694464579765, 4778.187708089633, 5178.922316165261, 5193.0, 5204.947950520446, 5215.947840521622, 5216.791328346823, 5000.2499625056535, 5002.249662550574, 5007.198848184273, 5008.84973450797, 5036.093503169464, 4934.753262336869, 5020.924686129711, 5060.949390506122, 5104.336436263262, 5115.693058416507, 4943.950560494421, 4971.975140124277, 4973.52751488608, 4975.751212439363, 5025.346704928409, 4860.73265970368, 4962.057209130254, 4963.0, 4972.627052970969, 5013.022460620144, 4244.0663054128045, 4260.382244574581, 4266.4240327556, 4321.984333681582, 4323.156984388014, 3733.8133093345223, 3762.473253744478, 3767.698584113264, 3802.258559580855, 3809.8095095245126, 4375.496817865923, 4388.166248412791, 4388.846390376385, 4389.714668546534, 4429.557044295545, 4939.431965324034, 4988.451270360258, 5035.320231768737, 5069.543741063322, 5086.54221120101, 4326.870193894189, 4331.913361732748, 4339.218940590661, 4342.1749867525705, 4382.846600368972, 4470.284754439339, 4505.549445055468, 4516.209663308908, 4528.388667529841, 4544.954550454519, 4748.0978614063215, 4794.065157294294, 4818.807247710192, 4828.95171048285, 4833.564979151894, 5007.774650140679, 5063.822766203165, 5064.645474816727, 5065.594752419871, 5118.257852611276, 4653.162430762495, 4775.116603428377, 4794.232922732346, 4804.615630749462, 4835.178019736582, 4944.332515110558, 4954.1825598775795, 4977.576905963034, 5014.623903207201, 5022.397312322545, 5031.874203144951, 5034.219695947134, 5035.194368900959, 5042.4705405931845, 5086.872828179326, 4797.40032495938, 4852.975735121302, 4879.146149423907, 4885.828995985124, 4932.186189278729, 4881.29221262922, 4899.167141585867, 4900.803967841246, 4908.067467181224, 4942.283368911416, 4818.301346304696, 4823.059503396944, 4825.662203645711, 4838.7338696370625, 4874.926876096933, 4872.4153101628035, 4932.062908047459, 4961.627877909099, 4975.6019518437715, 5008.57427118699, 4806.4953179917, 4809.0862736080035, 4809.326694262876, 4814.518548145157, 4827.42070951488], "unit": "score", "name": "dojo.html", "value": 4638.353138715595}, {"lowerIsBetter": false, "replicates": [542.9077056900327, 546.0962107711739, 563.1637019026746, 575.7409165875355, 592.0734051209854, 29511.0, 34137.317253654976, 34184.31631367371, 34308.828455857714, 34315.31369372617, 37583.81208093963, 37892.0, 37921.81039094808, 38199.809000954956, 38238.80880595593, 7623.237676232374, 7907.960460197691, 7909.050913890341, 7912.446128770988, 7912.564808935506, 7704.537727736326, 7816.0, 7834.686612535492, 7838.960805195966, 7840.882386764203, 7805.102413222467, 7808.80477988052, 7826.843463130763, 7870.370370370357, 7875.645595948167, 7742.109657389416, 7747.883781743279, 7756.457048006641, 7812.648430820626, 7813.76558703237, 7643.46495745298, 7806.960965195194, 7810.765677029698, 7811.609419529001, 7814.140444551095, 37180.814095929345, 37679.24641507182, 37817.43273850894, 37876.43185352222, 37879.62120378816, 3108.347247078116, 3175.285560748836, 3178.55500229968, 3183.283761153745, 3253.3493301339827, 28538.0, 28729.85635071832, 29516.70483295161, 29665.258368540744, 30384.088477345715, 3501.4222653262436, 3531.187826799825, 3550.3964326064374, 3569.8929032129076, 3614.6566076222716, 229230.85384573138, 230109.9999999983, 230127.0, 230204.0, 230511.0, 55268.0, 55989.72005139948, 56018.0, 56021.1596826048, 56032.439675603535, 62713.37286627075, 63905.04142437867, 64051.679741601925, 64078.35921640817, 64113.67943160348, 13583.0, 13759.862401375858, 13779.448822047207, 13791.379387927567, 13814.240216787972, 9764.609415623438, 9796.26528010402, 9798.31411801167, 9814.411135331902, 9822.214222862154, 19364.903175484313, 19393.806061939482, 19450.416487505398, 19460.0, 20357.592848142955, 7366.152892417441, 7429.145648250413, 7485.588292643957, 7520.984667069875, 7554.169041405441, 895.5164211325811, 907.4736652741394, 961.2646325560952, 976.6923419122953, 999.7950420163849, 25572.616410753853, 26830.5975410369, 27196.32009199786, 27203.591946120825, 27308.726912731017, 872.4634349874781, 956.799072194833, 994.8656931314325, 1020.5866624017285, 1021.9846702299471, 12900.35498225085, 13398.464061437628, 13419.194848308938, 13541.390637421142, 13583.932080339535, 267696.0, 271675.0, 272272.0, 272761.0, 273156.0, 47010.294845577344, 48283.517164828605, 48386.51613483891, 48399.5160048402, 48439.5156048435, 1043.6868939318174, 1203.18784820246, 1210.431097384228, 1235.4563991843381, 1249.4127759952808, 25896.61155082713, 26924.596131057657, 26998.190054298404, 27653.30866728348, 27736.86131569329, 37468.43797342988, 38056.0, 38181.618183818915, 38182.23635527329, 38191.61808381881, 205819.0, 210819.0, 211133.0, 211616.0, 211815.0, 27263.591046133926, 30984.691890596663, 31668.208294792814, 31825.522617161223, 31950.520742188422, 36606.267874642894, 38256.42615360828, 38796.0, 41854.79072604617, 42316.36525452059, 35228.47157292694, 35298.0, 35366.0, 35504.28991420209, 36035.0, 35605.1098722534, 35900.82049589735, 36084.81957590195, 36235.818820905726, 36304.63695363013, 35241.118972025906, 35430.0, 35515.39829496693, 35545.28909421849, 35744.28511429809, 30889.0, 32185.517217241293, 32345.838270808494, 32480.0, 32506.83746581252, 22206.55586888221, 22488.43778905475, 22559.88720056389, 25043.74956250414, 26204.344891377867], "unit": "score", "name": "ext.html", "value": 16995.835292210188}, {"lowerIsBetter": false, "replicates": [341.53210102160045, 356.07420706163975, 356.53828292361396, 358.6216541548665, 366.6938106680921, 15290.464833730808, 15830.0, 16337.18314084297, 16863.747043794323, 16910.323587056533, 10379.948100259488, 10490.16078713703, 10801.0, 10823.134149268059, 10827.458627068654, 4492.865214043584, 4659.767011649421, 4665.790039448233, 4674.929876051862, 4684.953150468486, 3500.7199424046016, 5135.614828887829, 5371.4897084776885, 5373.973130134344, 5377.569794416457, 5350.5452036576935, 5356.089464790975, 5356.651817631841, 5364.463553644624, 5375.543078838304, 5351.892962140755, 5698.51562617178, 5877.382874798127, 5880.441358070976, 5881.617694849842, 5158.993996170748, 5178.171492561172, 5190.792368305263, 5221.582273418117, 5224.033553792523, 12276.693082672915, 12295.508179672803, 12296.877031229662, 12299.815502767466, 14661.41354345825, 1800.297883825309, 1832.221305944968, 1908.8568357373254, 2072.5544008038346, 2472.814538909571, 8876.911230887674, 8967.506787126706, 9200.401973871676, 9233.53832308382, 9315.534223288876, 1716.7081596128564, 1805.5937414081857, 1826.725991101332, 1830.3319288459616, 1836.274671504748, 56899.0, 58823.58822088573, 59447.70276148592, 60870.0, 62122.99999999955, 9387.249020078378, 9644.614215431444, 9700.0, 9816.08586325674, 9898.455584942752, 12995.415206315738, 13239.139455935334, 13254.933725331312, 13310.401031953585, 13313.068085233941, 6700.363465470772, 6850.828729281709, 6884.173899132036, 6911.3779759821855, 7020.543664661781, 6424.51816113784, 6452.387023232785, 6464.644444555594, 6512.804615861532, 6535.183102112236, 4193.475815523059, 4224.577542245751, 4238.915221695549, 4248.086661367821, 4319.827206911751, 1602.87978401618, 1741.7213245880598, 1746.6943284925087, 1763.153686230591, 1833.402931058484, 859.5186695450568, 869.1742844297942, 882.5454890731279, 939.8261321655516, 958.5399008475971, 15851.762223566655, 16045.358185672676, 16159.757603635955, 16380.508584742476, 16725.247363868653, 845.564534264854, 882.9558522073999, 904.2810965282616, 958.0, 973.425678849468, 7262.0, 9172.6789562365, 9309.208717258973, 9445.669401570913, 9461.337706360626, 277684.0, 284780.0, 285731.0, 287322.0, 389131.0, 42006.579934200876, 43100.78449607732, 45283.54716452793, 45720.0, 57118.0, 967.8161149381594, 984.1241295247236, 993.0913214408879, 1004.0461561516588, 1015.0357160697367, 14706.926465367605, 14816.332445519492, 15071.09573425598, 15109.168995704902, 15261.160636165117, 31283.905063322676, 32048.839755801073, 32362.190945225615, 33074.66925330812, 33204.50193247152, 44663.77668111639, 45119.54880451285, 45419.31871022003, 45505.0, 45869.0, 7406.740764073232, 7409.703611855681, 7538.736144234926, 7620.8475830484185, 7738.419618528746, 10550.419726914786, 11183.496742646763, 11566.190366674253, 11703.590374336858, 11890.0, 10035.899641003496, 10304.639337623148, 10308.948455257676, 10502.579896804042, 10679.359238445719, 10078.79842403133, 10183.796324073624, 10187.796244075225, 10305.845412318971, 10361.222908281758, 10233.488325583543, 10824.56701731922, 10868.67393978182, 10909.18181136402, 10984.615538456115, 7638.541687498768, 7661.923380766121, 7715.344195743424, 7727.0, 7768.339691126317, 10413.11488523484, 10478.94760526223, 10511.106555942524, 10559.524821382902, 10792.946035269773], "unit": "score", "name": "jquery.html", "value": 7670.38770607894}, {"lowerIsBetter": false, "replicates": [1250.1561446023932, 1441.7909403136546, 1448.0587618048266, 1598.5763772600255, 1752.815954324795, 7301.6714247858845, 7460.925390746091, 7481.251874812516, 7488.812779680504, 7501.174870764212, 7066.222715501291, 7212.819679508002, 7214.278572142783, 7225.927740722591, 7227.855442891139, 1941.3302410668298, 1986.7814540400545, 1988.1848442138726, 2239.8320125990535, 2270.5118399544094, 2228.721409823772, 2288.9542209155807, 2289.5878741826464, 2290.3129061281547, 2291.346966114658, 2197.252934002439, 2207.624703800358, 2207.6688496725537, 2210.082815631511, 2315.9536809263805, 2240.5070884405404, 2247.8763667998255, 2249.4488850231714, 2252.087904398721, 2254.2448279826276, 2159.2334721173916, 2173.3479956013134, 2177.194438057913, 2192.0683709423433, 2199.48312146647, 7606.923930760732, 7626.885596716053, 7653.617319134021, 7672.117706463772, 7683.193264707237, 4486.865394038184, 4573.542645735433, 4605.125026245003, 4613.238815595423, 4635.9536404635855, 3067.417190733776, 3167.160702413862, 3192.074298453446, 3196.6323872754697, 3200.18395309197, 1032.2619327181026, 1043.212374657129, 1066.3921564708119, 1069.3316677076828, 1109.983350249747, 10218.437985910847, 10251.0, 10271.0, 10290.228232882564, 10298.330608510498, 4233.767142807175, 4269.573042695768, 4392.209402307615, 4394.714343567658, 4396.0, 8635.956820215984, 8647.394682372174, 8654.524001179869, 8673.35206310799, 8682.52246126469, 4745.193317136095, 4778.904421911542, 4779.498152693986, 4784.4497882743235, 4786.617070634341, 3746.38184699527, 4160.791960401968, 4299.527052024275, 4300.440942677495, 4310.267254566731, 3652.634736526326, 3679.2089700714473, 3711.5731690855896, 3720.813959302024, 3737.4580685800406, 1212.0727643352843, 1217.3852204636603, 1222.095649219589, 1234.7653945750278, 1242.2360248447321, 1175.2302242031483, 1177.3053898200103, 1203.9939800301117, 1204.8373469581495, 1221.096388672376, 7181.748638797617, 7250.057492525938, 7278.745243916437, 7300.671469783872, 7315.670794814246, 452.81887245102223, 462.5212904643678, 464.4357106116085, 464.5540281329961, 469.5633061253067, 5378.51593356592, 5385.676859388371, 5391.514763671288, 5393.7572809223675, 5443.0, 8922.375433719708, 9042.457452552868, 9327.766805829908, 9331.673391431268, 9338.766530836783, 9042.909570904207, 9105.726828195166, 9127.680531181377, 9215.216706579882, 9222.677206297747, 6807.65961701913, 6812.761553345609, 6889.311068893171, 7210.062691850026, 7234.348908598146, 6829.2487826338065, 6884.965575172092, 6891.965540172267, 6911.861762764616, 6928.4803639726215, 8128.593570321578, 8179.427440079137, 8276.627551760306, 8301.501909885426, 8313.210245026712, 8316.0, 8461.873071903803, 8531.95734021326, 8579.785505362415, 8627.611757470804, 6596.8350791230605, 6627.237867645283, 6630.436412904764, 6662.866742665216, 6666.2333831609985, 7112.182099058675, 7147.928520714726, 7151.642417878981, 7153.070100886852, 7215.422766178798, 6178.69106544662, 6317.305096439296, 6385.840353991188, 6437.581557198767, 6515.934840651533, 6367.363263673596, 6466.32103629131, 6577.572457790228, 6582.3746744059235, 6687.8328041797395, 6645.069690243273, 6671.833204169935, 6687.531872768859, 6698.83252918681, 6724.72230276246, 6109.358517355614, 6208.937910620836, 6249.437550620466, 6279.058141278845, 6280.183576135073, 6229.2524897012645, 6237.12680224778, 6284.151639528788, 6293.307736149111, 6305.464035557029], "unit": "score", "name": "mootools.html", "value": 4281.107839685086}, {"lowerIsBetter": false, "replicates": [317.4634867074642, 317.7251677299137, 317.7854947910163, 320.2058893943021, 325.14162610707734, 5215.374155101384, 5305.549028332592, 5320.536852365606, 5325.520703136717, 5328.094223981922, 5217.530422261995, 5222.660527065738, 5243.187305967572, 5250.264962905197, 5250.317458730369, 3905.7070719696135, 3993.6206060424215, 4066.329055705805, 4132.400801883732, 4139.089400331922, 4074.9185016299803, 4102.261592913274, 4104.179164167163, 4104.466419365478, 4113.362428823522, 4045.9480535060948, 4062.5124985001694, 4065.125997910449, 4070.87787366378, 4083.775392353419, 3899.8245078971513, 3966.4248683940955, 3968.523777146732, 3986.7009974252046, 4082.122343696105, 3563.2695297463956, 3574.3744844652083, 3580.3555360035184, 3585.0858031202138, 3587.157018100744, 5024.949750502485, 5035.3454050973505, 5036.370453693288, 5040.672356296829, 5047.141985862412, 4700.976495117503, 4706.1999460091865, 4707.223308154151, 4707.905841883143, 4717.882052948669, 5505.889882202374, 5520.475554822286, 5527.834164975057, 5529.0, 5531.668099914018, 3911.2959667259884, 3930.8231129599235, 3932.6067393260446, 3933.724639275252, 3939.98030009851, 5610.24261724666, 5802.274715660543, 5815.9531284368795, 5829.854253643651, 5850.414958504116, 3940.054386947112, 3946.6842652587725, 3961.6632586229916, 3962.7424217425773, 3967.1867267210155, 4004.419359192959, 4005.599440055971, 4006.1186538961965, 4009.278329900588, 4014.5182578090817, 4612.238980568236, 4614.192516309699, 4617.422822147231, 4625.537446255347, 4628.0, 5522.530584900248, 5536.169574563848, 5536.695481748542, 5542.722863856791, 5551.528120109755, 1389.4858902206047, 1402.5441731437325, 1407.3174510362671, 1409.7251036048078, 1413.7455258053444, 923.4736200365727, 929.702495201529, 934.2855859497762, 936.0873148679982, 953.0993211415284, 4713.175194340976, 4790.4251489820745, 4845.8546243612045, 4881.414230292387, 4894.3147959285725, 5739.971300143473, 5743.770249190069, 5749.568782341341, 5750.079987202112, 5771.365149833515, 4879.804807807719, 4882.829100981519, 4888.877778055577, 4889.119958407449, 4890.0, 3047.7866549341334, 3085.6451508076857, 3103.572356715936, 3104.62744470665, 3113.6263648361887, 5474.589405794582, 5482.424345443751, 5484.698341591171, 5486.753096110685, 5486.807961721321, 5747.770089196385, 5870.090136028923, 5901.940980590225, 5927.1405646181065, 5931.110333450017, 5430.945690543044, 5450.29146210998, 5454.290942177491, 5454.3454785426, 5463.699496527729, 5763.481286684051, 5771.884562308815, 5774.595778295479, 5778.219940308173, 5779.566532510163, 5640.294963129609, 5645.322561292671, 5648.039833228278, 5650.124230744241, 5654.6324488908085, 5467.152591348347, 5469.75386107634, 5470.343558772973, 5472.288602481652, 5477.014137455137, 3868.3037053330672, 3976.721629485908, 3978.085040440657, 3982.38273067675, 3984.5019372578427, 5720.656760594377, 5733.598648094593, 5743.62666426681, 5747.195392645117, 5747.3103227612955, 5554.75003624846, 5560.694161821139, 5563.13771365439, 5567.66594004361, 5568.832935011957, 5558.194061861089, 5561.888762224814, 5563.193336966198, 5570.944290557205, 5573.6098473106495, 5457.61796674229, 5477.370102438271, 5477.397486276586, 5480.561555075664, 5482.835514934558, 5442.619016668795, 5554.722263886871, 5580.135079062752, 5582.106862901916, 5586.832395028156, 5432.565394768488, 5447.727613619224, 5454.645448045864, 5466.262054622575, 5472.042392581203], "unit": "score", "name": "prototype.html", "value": 4167.874201208705}, {"lowerIsBetter": false, "replicates": [658.6937074260468, 719.5502810743285, 733.5048842031628, 779.3180966654178, 797.7646594254694, 11694.883051169485, 14329.0, 14361.92819035906, 14383.0, 14451.566453006426, 13311.334433278345, 13384.330783460837, 13488.190708557493, 13502.12236204646, 13548.254845983467, 655.2890114226046, 809.4172196018857, 810.2221867007651, 825.4180802534199, 826.0294154368623, 830.6469750356105, 831.3723139030024, 831.629924683516, 831.6714897615439, 833.1418638802044, 859.9699010534632, 870.4342177584557, 871.6905498548019, 872.0494660819705, 872.0668884293808, 686.4062585863243, 842.7387509871959, 856.4989481153533, 862.8835107260502, 863.0980625246601, 623.3984205241918, 625.7027911741932, 626.3110578363809, 626.4737620398841, 627.491731697322, 12590.74818503634, 12636.49454021838, 12715.491380344774, 12739.36303184837, 12750.171238869443, 11626.244294120856, 12285.324307163102, 12488.313142777144, 12615.936920315431, 12688.17526860751, 9579.808403831954, 9673.613055477772, 9692.0, 9860.852087218625, 10010.0, 3270.084376374619, 3273.8035717857006, 3347.73218142548, 3376.3247350529746, 3380.256343604403, 44344.0, 44423.555764442266, 44441.333379999, 44476.0, 44590.0, 9794.902050979399, 9889.357191782656, 9896.802063958681, 10068.44623545712, 10142.137918276881, 16967.236474358684, 16968.49094527166, 16975.0, 17011.23449444778, 17032.2335494903, 6489.805305840832, 6630.1049358336, 6708.228553716288, 6711.630860302633, 6836.4530837532875, 2886.307286251327, 3554.862444017941, 3742.9438558421643, 3781.1870447853844, 3798.0884587699306, 2932.0470846974818, 2951.985240073786, 2969.584258203853, 2971.524556071018, 2973.405318936221, 500.7846625950803, 518.5410911343413, 518.7095226673075, 590.8493334199752, 610.3926593039865, 552.4806681719172, 636.920384951881, 646.6281887914467, 648.3678413546849, 675.2470994840717, 8130.146334634778, 8477.660893564189, 8573.314134869195, 8619.784505387415, 8647.178518040777, 551.7186235020089, 642.081822993115, 642.097852517214, 653.4119292636665, 657.6021506988203, 3761.567419746709, 3796.620337966181, 3939.6060393960947, 3988.8404463821703, 4012.2814836824873, 51672.22491662628, 52854.735726321895, 52867.20699189515, 52911.0, 52913.206301905506, 43393.78303108464, 44402.0, 44763.77618111888, 44895.0, 45016.54983450124, 41304.586954130675, 41550.0, 41776.99999999939, 42032.57967420348, 42127.36808947868, 7706.0, 7765.1846556110795, 7779.0, 7833.49082309648, 7965.163657815846, 30743.69256307498, 31196.376072478877, 31447.84276078605, 32317.676823231468, 33081.50377744384, 35346.46980295349, 35994.46008309825, 36150.0, 36323.547058118435, 36755.63244367629, 10608.151347892304, 10896.564137434414, 10998.34009959405, 11228.55085796559, 11507.769844603228, 11752.353620550952, 12012.279263244232, 12308.753824923273, 12312.445939932904, 12347.69130771702, 11295.152863535104, 11587.8261826071, 11717.941410292893, 11898.464569094585, 12101.031917446408, 11514.30914145154, 11631.709207269547, 12144.0, 12145.69635759113, 12157.513699451923, 11383.829242561535, 11689.824652630048, 11795.29228246308, 12042.939785301018, 12076.154669173073, 9500.762480938032, 9544.369732920077, 9563.378380405251, 9628.277879159232, 10126.746831329276, 9696.95151524238, 10003.749906252402, 10083.294169408364, 10084.495775211064, 10094.545745441326], "unit": "score", "name": "yui.html", "value": 6059.456703725903}], "name": "dromaeo_css", "value": 6347.145352354273}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 115.0, 115.0, 113.0, 101.0, 113.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [157.0, 133.0, 155.0, 170.0, 132.0, 152.0, 153.0, 132.0, 174.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 160.0, 162.0, 162.0, 161.0, 163.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 80.0, 109.0, 102.0, 74.0, 74.0, 74.0, 117.0, 93.0, 75.0], "unit": "score", "name": "audio-fft", "value": 87.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 94.0, 95.0, 93.0, 135.0, 94.0, 94.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 148.0, 145.0, 147.0, 146.0, 148.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 64.0, 63.0, 74.0, 62.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 64.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 81.0, 83.0, 83.0, 81.0, 90.0, 81.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [125.0, 120.0, 124.0, 115.0, 133.0, 118.0, 131.0, 124.0, 117.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [144.0, 132.0, 151.0, 144.0, 145.0, 132.0, 141.0, 143.0, 144.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 66.0, 69.0, 68.0, 68.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1519.8}]} 13:19:21 INFO - Return code: 0 13:19:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:19:21 ERROR - # TBPL SUCCESS # 13:19:21 INFO - Running post-action listener: _resource_record_post_action 13:19:21 INFO - Running post-run listener: _resource_record_post_run 13:19:22 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 126976; Write bytes: 518017024; Read time: 44; Write time: 899064 13:19:22 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233123840; Read time: 0; Write time: 522936 13:19:22 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 126976; Write bytes: 284893184; Read time: 44; Write time: 376128 13:19:22 INFO - Running post-run listener: _upload_blobber_files 13:19:22 INFO - Blob upload gear active. 13:19:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:19:22 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 13:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:19:22 INFO - (blobuploader) - INFO - Open directory for files ... 13:19:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:19:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:19:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:23 INFO - (blobuploader) - INFO - Done attempting. 13:19:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:19:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:19:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:24 INFO - (blobuploader) - INFO - Done attempting. 13:19:24 INFO - (blobuploader) - INFO - Iteration through files over. 13:19:24 INFO - Return code: 0 13:19:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:19:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:19:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997d6b1b0469bb299ce291662df406453c9da7f3b1780b7e0779ec1ba4dc02a3dac8bec8400feb64b21285ff2fed3bcc2b5021c5192151a02b513287fc97c6d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7faa228cd088a05980f62f21d035e3b8e33fc09e87bb29ebc50386377d12806ce1999f5fb44b130e230d418b40312810de69e5281d59a6c643083d7a401c41f5"} 13:19:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:19:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:19:24 INFO - Contents: 13:19:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997d6b1b0469bb299ce291662df406453c9da7f3b1780b7e0779ec1ba4dc02a3dac8bec8400feb64b21285ff2fed3bcc2b5021c5192151a02b513287fc97c6d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7faa228cd088a05980f62f21d035e3b8e33fc09e87bb29ebc50386377d12806ce1999f5fb44b130e230d418b40312810de69e5281d59a6c643083d7a401c41f5"} 13:19:24 INFO - Running post-run listener: copy_logs_to_upload_dir 13:19:24 INFO - Copying logs to upload dir... 13:19:24 INFO - mkdir: /builds/slave/test/build/upload/logs 13:19:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.330117 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-25 13:19:24.354687) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 13:19:24.358057) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997d6b1b0469bb299ce291662df406453c9da7f3b1780b7e0779ec1ba4dc02a3dac8bec8400feb64b21285ff2fed3bcc2b5021c5192151a02b513287fc97c6d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7faa228cd088a05980f62f21d035e3b8e33fc09e87bb29ebc50386377d12806ce1999f5fb44b130e230d418b40312810de69e5281d59a6c643083d7a401c41f5"} build_url:https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/Wd4YfPQHTDO3Gss8HN9yEQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997d6b1b0469bb299ce291662df406453c9da7f3b1780b7e0779ec1ba4dc02a3dac8bec8400feb64b21285ff2fed3bcc2b5021c5192151a02b513287fc97c6d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7faa228cd088a05980f62f21d035e3b8e33fc09e87bb29ebc50386377d12806ce1999f5fb44b130e230d418b40312810de69e5281d59a6c643083d7a401c41f5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 13:19:24.386460) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 13:19:24.386790) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458933437.160389-2130114277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 13:19:24.468347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 13:19:24.468682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 13:19:24.468973) ========= ========= Total master_lag: 0.29 =========