builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1459843931.34 results: success (0) buildid: 20160405002006 builduid: 24073ddcadba4fd18b1f43c2ccff8875 revision: ff96d9731ec72261815762f219cfafc7ff5b9495 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.336998) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.337364) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.337662) ========= 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=82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006527 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.368999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.369287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.398028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.398295) ========= 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=82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004664 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.476965) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.477240) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.477573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.478436) ========= 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=82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 01:12:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 57.4M=0s 2016-04-05 01:12:11 (57.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154495 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.699301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.699590) ========= 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=82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018203 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.768320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:11.768637) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff96d9731ec72261815762f219cfafc7ff5b9495 --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 ff96d9731ec72261815762f219cfafc7ff5b9495 --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=82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 01:12:11,930 truncating revision to first 12 chars 2016-04-05 01:12:11,930 Setting DEBUG logging. 2016-04-05 01:12:11,930 attempt 1/10 2016-04-05 01:12:11,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff96d9731ec7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 01:12:12,189 unpacking tar archive at: fx-team-ff96d9731ec7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566915 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:12.354806) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:12.355129) ========= echo ff96d9731ec72261815762f219cfafc7ff5b9495 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ff96d9731ec72261815762f219cfafc7ff5b9495'] 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=82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ff96d9731ec72261815762f219cfafc7ff5b9495 program finished with exit code 0 elapsedTime=0.004051 script_repo_revision: 'ff96d9731ec72261815762f219cfafc7ff5b9495' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:12.407268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:12.407588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 01:12:12.425726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-05 01:12:12.425996) ========= /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=82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:12:12 INFO - MultiFileLogger online at 20160405 01:12:12 in /builds/slave/test 01:12:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:12:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:12:12 INFO - {'append_to_log': False, 01:12:12 INFO - 'base_work_dir': '/builds/slave/test', 01:12:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:12:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:12:12 INFO - 'branch': 'Fx-Team-Non-PGO', 01:12:12 INFO - 'buildbot_json_path': 'buildprops.json', 01:12:12 INFO - 'config_files': ('talos/linux_config.py',), 01:12:12 INFO - 'default_actions': ('clobber', 01:12:12 INFO - 'read-buildbot-config', 01:12:12 INFO - 'download-and-extract', 01:12:12 INFO - 'populate-webroot', 01:12:12 INFO - 'create-virtualenv', 01:12:12 INFO - 'install', 01:12:12 INFO - 'run-tests'), 01:12:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:12:12 INFO - 'download_minidump_stackwalk': True, 01:12:12 INFO - 'download_symbols': 'ondemand', 01:12:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:12:12 INFO - 'tooltool.py': '/tools/tooltool.py', 01:12:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:12:12 INFO - '/tools/misc-python/virtualenv.py')}, 01:12:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:12:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:12:12 INFO - 'installer_path': 'installer.exe', 01:12:12 INFO - 'log_level': 'info', 01:12:12 INFO - 'log_name': 'talos', 01:12:12 INFO - 'log_to_console': True, 01:12:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:12:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:12:12 INFO - 'opt_config_files': (), 01:12:12 INFO - 'pip_index': False, 01:12:12 INFO - 'sps_profile': False, 01:12:12 INFO - 'sps_profile_interval': 0, 01:12:12 INFO - 'suite': 'dromaeojs', 01:12:12 INFO - 'system_bits': '32', 01:12:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:12:12 INFO - 'title': 'talos-linux64-ix-055', 01:12:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:12:12 INFO - 'use_talos_json': True, 01:12:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:12:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:12:12 INFO - 'work_dir': 'build'} 01:12:12 INFO - ##### 01:12:12 INFO - ##### Running clobber step. 01:12:12 INFO - ##### 01:12:12 INFO - Running pre-action listener: _resource_record_pre_action 01:12:12 INFO - Running main action method: clobber 01:12:12 INFO - rmtree: /builds/slave/test/build 01:12:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:12:13 INFO - Running post-action listener: _resource_record_post_action 01:12:13 INFO - ##### 01:12:13 INFO - ##### Running read-buildbot-config step. 01:12:13 INFO - ##### 01:12:13 INFO - Running pre-action listener: _resource_record_pre_action 01:12:13 INFO - Running main action method: read_buildbot_config 01:12:13 INFO - Using buildbot properties: 01:12:13 INFO - { 01:12:13 INFO - "project": "", 01:12:13 INFO - "product": "firefox", 01:12:13 INFO - "script_repo_revision": "production", 01:12:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:12:13 INFO - "repository": "", 01:12:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:12:13 INFO - "buildid": "20160405002006", 01:12:13 INFO - "pgo_build": "False", 01:12:13 INFO - "basedir": "/builds/slave/test", 01:12:13 INFO - "buildnumber": 2754, 01:12:13 INFO - "slavename": "talos-linux64-ix-055", 01:12:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:12:13 INFO - "platform": "ubuntu64_hw", 01:12:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:12:13 INFO - "branch": "fx-team", 01:12:13 INFO - "repo_path": "integration/fx-team", 01:12:13 INFO - "revision": "ff96d9731ec72261815762f219cfafc7ff5b9495", 01:12:13 INFO - "stage_platform": "linux64", 01:12:13 INFO - "builduid": "24073ddcadba4fd18b1f43c2ccff8875", 01:12:13 INFO - "slavebuilddir": "test" 01:12:13 INFO - } 01:12:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 01:12:13 INFO - Running post-action listener: _resource_record_post_action 01:12:13 INFO - ##### 01:12:13 INFO - ##### Running download-and-extract step. 01:12:13 INFO - ##### 01:12:13 INFO - Running pre-action listener: _resource_record_pre_action 01:12:13 INFO - Running main action method: download_and_extract 01:12:13 INFO - mkdir: /builds/slave/test/build/tests 01:12:13 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')]} 01:12:13 INFO - https://queue.taskcluster.net/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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 01:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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 01:12:14 INFO - Downloaded 1361 bytes. 01:12:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:12:14 INFO - Using the following test package requirements: 01:12:14 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:12:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:12:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:12:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:12:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:12:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:12:14 INFO - u'jsshell-linux-x86_64.zip'], 01:12:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:12:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:12:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:12:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:12:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:12:14 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:12:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:12:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:12:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:12:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:12:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:12:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:12: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')]} 01:12:14 INFO - https://queue.taskcluster.net/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:12:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:12:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:12:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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 01:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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 01:12:16 INFO - Downloaded 22125516 bytes. 01:12:16 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'] 01:12:16 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 01:12:17 INFO - Return code: 0 01:12:17 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 01:12: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')]} 01:12:17 INFO - https://queue.taskcluster.net/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:12:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:12:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:12:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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 01:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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 01:12:20 INFO - Downloaded 22125516 bytes. 01:12:20 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'] 01:12:20 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 01:12:21 INFO - Return code: 0 01:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:21 INFO - https://queue.taskcluster.net/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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 01:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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 01:12:22 INFO - Downloaded 10847584 bytes. 01:12:22 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'] 01:12:22 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 01:12:23 INFO - Return code: 0 01:12:23 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')]} 01:12:23 INFO - https://queue.taskcluster.net/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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 01:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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 01:12:24 INFO - Downloaded 54078370 bytes. 01:12:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:12:24 INFO - mkdir: /builds/slave/test/properties 01:12:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:12:24 INFO - Writing to file /builds/slave/test/properties/build_url 01:12:24 INFO - Contents: 01:12:24 INFO - build_url:https://queue.taskcluster.net/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:12:25 INFO - Running post-action listener: _resource_record_post_action 01:12:25 INFO - Running post-action listener: set_extra_try_arguments 01:12:25 INFO - ##### 01:12:25 INFO - ##### Running populate-webroot step. 01:12:25 INFO - ##### 01:12:25 INFO - Running pre-action listener: _resource_record_pre_action 01:12:25 INFO - Running main action method: populate_webroot 01:12:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:12:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:12:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:12:25 INFO - '--tppagecycles', 01:12:25 INFO - '7'], 01:12:25 INFO - 'tests': ['tsvgm']}}, 01:12:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:12:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:12:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:12:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:12:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:12:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:12:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:12:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:25 INFO - 'talos_options': ['--e10s'], 01:12:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:12:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:25 INFO - 'tests': ['damp', 'tps']}, 01:12:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:25 INFO - 'talos_options': ['--e10s'], 01:12:25 INFO - 'tests': ['damp', 'tps']}, 01:12:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:12:25 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 01:12:25 INFO - 'tests': ['dromaeo_dom']}, 01:12:25 INFO - 'other': {'tests': ['a11yr', 01:12:25 INFO - 'ts_paint', 01:12:25 INFO - 'tpaint', 01:12:25 INFO - 'sessionrestore', 01:12:25 INFO - 'sessionrestore_no_auto_restore', 01:12:25 INFO - 'tabpaint']}, 01:12:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:12:25 INFO - 'tests': ['a11yr', 01:12:25 INFO - 'ts_paint', 01:12:25 INFO - 'tpaint', 01:12:25 INFO - 'sessionrestore', 01:12:25 INFO - 'sessionrestore_no_auto_restore', 01:12:25 INFO - 'tabpaint']}, 01:12:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:12:25 INFO - 'tests': ['a11yr', 01:12:25 INFO - 'ts_paint', 01:12:25 INFO - 'tpaint', 01:12:25 INFO - 'sessionrestore', 01:12:25 INFO - 'sessionrestore_no_auto_restore', 01:12:25 INFO - 'tabpaint']}, 01:12:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:12:25 INFO - 'tests': ['a11yr', 01:12:25 INFO - 'ts_paint', 01:12:25 INFO - 'tpaint', 01:12:25 INFO - 'sessionrestore', 01:12:25 INFO - 'sessionrestore_no_auto_restore', 01:12:25 INFO - 'tabpaint']}, 01:12:25 INFO - 'other_l64': {'tests': ['a11yr', 01:12:25 INFO - 'ts_paint', 01:12:25 INFO - 'tpaint', 01:12:25 INFO - 'sessionrestore', 01:12:25 INFO - 'sessionrestore_no_auto_restore', 01:12:25 INFO - 'tabpaint']}, 01:12:25 INFO - 'other_nol64': {'tests': ['a11yr', 01:12:25 INFO - 'ts_paint', 01:12:25 INFO - 'tpaint', 01:12:25 INFO - 'sessionrestore', 01:12:25 INFO - 'sessionrestore_no_auto_restore', 01:12:25 INFO - 'tabpaint']}, 01:12:25 INFO - 'svgr': {'tests': ['tsvgx', 01:12:25 INFO - 'tsvgr_opacity', 01:12:25 INFO - 'tart', 01:12:25 INFO - 'tscrollx', 01:12:25 INFO - 'cart']}, 01:12:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:12:25 INFO - 'tests': ['tsvgx', 01:12:25 INFO - 'tsvgr_opacity', 01:12:25 INFO - 'tart', 01:12:25 INFO - 'tscrollx', 01:12:25 INFO - 'cart']}, 01:12:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:25 INFO - 'tests': ['tp5o']}, 01:12:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:25 INFO - 'talos_options': ['--e10s'], 01:12:25 INFO - 'tests': ['tp5o']}, 01:12:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:25 INFO - 'talos_options': ['--xperf_path', 01:12:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:12:25 INFO - 'tests': ['tp5n']}, 01:12:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:25 INFO - 'talos_options': ['--e10s', 01:12:25 INFO - '--xperf_path', 01:12:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:12:25 INFO - 'tests': ['tp5n']}}, 01:12:25 INFO - 'talos.zip': {'path': '', 01:12:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:12:25 INFO - Running post-action listener: _resource_record_post_action 01:12:25 INFO - ##### 01:12:25 INFO - ##### Running create-virtualenv step. 01:12:25 INFO - ##### 01:12:25 INFO - Running pre-action listener: _resource_record_pre_action 01:12:25 INFO - Running main action method: create_virtualenv 01:12:25 INFO - Creating virtualenv /builds/slave/test/build/venv 01:12:25 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 01:12:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:12:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:12:25 INFO - Using real prefix '/usr' 01:12:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:12:25 INFO - Installing distribute.............................................................................................................................................................................................done. 01:12:27 INFO - Installing pip.................done. 01:12:27 INFO - Return code: 0 01:12:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c15bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05410>, '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 0x1b06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b067a0>, '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': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', '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 01:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:12:27 INFO - Using env: {'DISPLAY': ':0', 01:12:27 INFO - 'HOME': '/home/cltbld', 01:12:27 INFO - 'LANG': 'en_US.UTF-8', 01:12:27 INFO - 'LANGUAGE': 'en_US:en', 01:12:27 INFO - 'LOGNAME': 'cltbld', 01:12:27 INFO - 'MAIL': '/var/mail/cltbld', 01:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:27 INFO - 'MOZ_NO_REMOTE': '1', 01:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:12:27 INFO - 'NO_EM_RESTART': '1', 01:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:27 INFO - 'PWD': '/builds/slave/test', 01:12:27 INFO - 'SHELL': '/bin/bash', 01:12:27 INFO - 'SHLVL': '1', 01:12:27 INFO - 'TERM': 'linux', 01:12:27 INFO - 'TMOUT': '86400', 01:12:27 INFO - 'USER': 'cltbld', 01:12:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', 01:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:27 INFO - '_': '/tools/buildbot/bin/python'} 01:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:28 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 01:12:28 INFO - Cleaning up... 01:12:28 INFO - Return code: 0 01:12:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:12:28 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')]} 01:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:28 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')]} 01:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:28 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 0x7f7c15bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05410>, '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 0x1b06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b067a0>, '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': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', '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 01:12:28 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 01:12:28 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 01:12:28 INFO - Using env: {'DISPLAY': ':0', 01:12:28 INFO - 'HOME': '/home/cltbld', 01:12:28 INFO - 'LANG': 'en_US.UTF-8', 01:12:28 INFO - 'LANGUAGE': 'en_US:en', 01:12:28 INFO - 'LOGNAME': 'cltbld', 01:12:28 INFO - 'MAIL': '/var/mail/cltbld', 01:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:28 INFO - 'MOZ_NO_REMOTE': '1', 01:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:12:28 INFO - 'NO_EM_RESTART': '1', 01:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:28 INFO - 'PWD': '/builds/slave/test', 01:12:28 INFO - 'SHELL': '/bin/bash', 01:12:28 INFO - 'SHLVL': '1', 01:12:28 INFO - 'TERM': 'linux', 01:12:28 INFO - 'TMOUT': '86400', 01:12:28 INFO - 'USER': 'cltbld', 01:12:28 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', 01:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:28 INFO - '_': '/tools/buildbot/bin/python'} 01:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:28 INFO - Downloading/unpacking psutil>=0.7.1 01:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:12:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:12:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:12:30 INFO - Installing collected packages: psutil 01:12:30 INFO - Running setup.py install for psutil 01:12:30 INFO - building 'psutil._psutil_linux' extension 01:12:30 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 01:12:30 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 01:12:30 INFO - building 'psutil._psutil_posix' extension 01:12:30 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 01:12:30 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 01:12:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:12:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:12:30 INFO - Successfully installed psutil 01:12:30 INFO - Cleaning up... 01:12:30 INFO - Return code: 0 01:12:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:30 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 0x7f7c15bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05410>, '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 0x1b06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b067a0>, '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': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', '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 01:12:30 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 01:12:30 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 01:12:30 INFO - Using env: {'DISPLAY': ':0', 01:12:30 INFO - 'HOME': '/home/cltbld', 01:12:30 INFO - 'LANG': 'en_US.UTF-8', 01:12:30 INFO - 'LANGUAGE': 'en_US:en', 01:12:30 INFO - 'LOGNAME': 'cltbld', 01:12:30 INFO - 'MAIL': '/var/mail/cltbld', 01:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:30 INFO - 'MOZ_NO_REMOTE': '1', 01:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:12:30 INFO - 'NO_EM_RESTART': '1', 01:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:30 INFO - 'PWD': '/builds/slave/test', 01:12:30 INFO - 'SHELL': '/bin/bash', 01:12:30 INFO - 'SHLVL': '1', 01:12:30 INFO - 'TERM': 'linux', 01:12:30 INFO - 'TMOUT': '86400', 01:12:30 INFO - 'USER': 'cltbld', 01:12:30 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', 01:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:30 INFO - '_': '/tools/buildbot/bin/python'} 01:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:12:31 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 01:12:31 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 01:12:31 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 01:12:31 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 01:12:31 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 01:12:31 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 01:12:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:12:33 INFO - Installing collected packages: mozsystemmonitor 01:12:33 INFO - Running setup.py install for mozsystemmonitor 01:12:33 INFO - Successfully installed mozsystemmonitor 01:12:33 INFO - Cleaning up... 01:12:33 INFO - Return code: 0 01:12:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:33 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 0x7f7c15bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05410>, '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 0x1b06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b067a0>, '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': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', '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 01:12:33 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 01:12:33 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 01:12:33 INFO - Using env: {'DISPLAY': ':0', 01:12:33 INFO - 'HOME': '/home/cltbld', 01:12:33 INFO - 'LANG': 'en_US.UTF-8', 01:12:33 INFO - 'LANGUAGE': 'en_US:en', 01:12:33 INFO - 'LOGNAME': 'cltbld', 01:12:33 INFO - 'MAIL': '/var/mail/cltbld', 01:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:33 INFO - 'MOZ_NO_REMOTE': '1', 01:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:12:33 INFO - 'NO_EM_RESTART': '1', 01:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:33 INFO - 'PWD': '/builds/slave/test', 01:12:33 INFO - 'SHELL': '/bin/bash', 01:12:33 INFO - 'SHLVL': '1', 01:12:33 INFO - 'TERM': 'linux', 01:12:33 INFO - 'TMOUT': '86400', 01:12:33 INFO - 'USER': 'cltbld', 01:12:33 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', 01:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:33 INFO - '_': '/tools/buildbot/bin/python'} 01:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:33 INFO - Downloading/unpacking blobuploader==1.2.4 01:12:33 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 01:12:33 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 01:12:33 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 01:12:33 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 01:12:33 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 01:12:33 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 01:12:35 INFO - Downloading blobuploader-1.2.4.tar.gz 01:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:12:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:12:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:36 INFO - Downloading docopt-0.6.1.tar.gz 01:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:12:36 INFO - Installing collected packages: blobuploader, requests, docopt 01:12:36 INFO - Running setup.py install for blobuploader 01:12:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:12:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:12:36 INFO - Running setup.py install for requests 01:12:36 INFO - Running setup.py install for docopt 01:12:36 INFO - Successfully installed blobuploader requests docopt 01:12:36 INFO - Cleaning up... 01:12:36 INFO - Return code: 0 01:12:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:12: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')]} 01:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12: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')]} 01:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:36 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 0x7f7c15bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05410>, '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 0x1b06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b067a0>, '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': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', '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 01:12:36 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 01:12:36 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 01:12:36 INFO - Using env: {'DISPLAY': ':0', 01:12:36 INFO - 'HOME': '/home/cltbld', 01:12:36 INFO - 'LANG': 'en_US.UTF-8', 01:12:36 INFO - 'LANGUAGE': 'en_US:en', 01:12:36 INFO - 'LOGNAME': 'cltbld', 01:12:36 INFO - 'MAIL': '/var/mail/cltbld', 01:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:36 INFO - 'MOZ_NO_REMOTE': '1', 01:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:12:36 INFO - 'NO_EM_RESTART': '1', 01:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:36 INFO - 'PWD': '/builds/slave/test', 01:12:36 INFO - 'SHELL': '/bin/bash', 01:12:36 INFO - 'SHLVL': '1', 01:12:36 INFO - 'TERM': 'linux', 01:12:36 INFO - 'TMOUT': '86400', 01:12:36 INFO - 'USER': 'cltbld', 01:12:36 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', 01:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:36 INFO - '_': '/tools/buildbot/bin/python'} 01:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:12:37 INFO - Running setup.py (path:/tmp/pip-dG9DFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:12:37 INFO - Running setup.py (path:/tmp/pip-eWtxxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:12:37 INFO - Running setup.py (path:/tmp/pip-f9XJE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:12:37 INFO - Running setup.py (path:/tmp/pip-6ywu7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:12:37 INFO - Running setup.py (path:/tmp/pip-k38pvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:12:37 INFO - Running setup.py (path:/tmp/pip-Zepyum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:12:37 INFO - Running setup.py (path:/tmp/pip-u4Yjdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:12:37 INFO - Running setup.py (path:/tmp/pip-hN7vl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:12:37 INFO - Running setup.py (path:/tmp/pip-FyRCAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:12:37 INFO - Running setup.py (path:/tmp/pip-38R6Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:12:37 INFO - Running setup.py (path:/tmp/pip-Q4bavR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:12:37 INFO - Running setup.py (path:/tmp/pip-f4Sc93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:12:37 INFO - Running setup.py (path:/tmp/pip-hFENaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:12:37 INFO - Running setup.py (path:/tmp/pip-Ddg7jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:12:38 INFO - Running setup.py (path:/tmp/pip-Wea0eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:12:38 INFO - Running setup.py (path:/tmp/pip-8DfWLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:12:38 INFO - Running setup.py (path:/tmp/pip-XhGRRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:12:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:12:38 INFO - Running setup.py install for manifestparser 01:12:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:12:38 INFO - Running setup.py install for mozcrash 01:12:38 INFO - Running setup.py install for mozdebug 01:12:38 INFO - Running setup.py install for mozdevice 01:12:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:12:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:12:38 INFO - Running setup.py install for mozfile 01:12:38 INFO - Running setup.py install for mozhttpd 01:12:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:12:38 INFO - Running setup.py install for mozinfo 01:12:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:12:38 INFO - Running setup.py install for mozInstall 01:12:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:12:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:12:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:12:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:12:39 INFO - Running setup.py install for mozleak 01:12:39 INFO - Running setup.py install for mozlog 01:12:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:12:39 INFO - Running setup.py install for moznetwork 01:12:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:12:39 INFO - Running setup.py install for mozprocess 01:12:39 INFO - Running setup.py install for mozprofile 01:12:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:12:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:12:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:12:39 INFO - Running setup.py install for mozrunner 01:12:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:12:39 INFO - Running setup.py install for mozscreenshot 01:12:39 INFO - Running setup.py install for moztest 01:12:39 INFO - Running setup.py install for mozversion 01:12:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:12:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:12:40 INFO - Cleaning up... 01:12:40 INFO - Return code: 0 01:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:40 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 0x7f7c15bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05410>, '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 0x1b06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b067a0>, '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': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', '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 01:12:40 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 01:12:40 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 01:12:40 INFO - Using env: {'DISPLAY': ':0', 01:12:40 INFO - 'HOME': '/home/cltbld', 01:12:40 INFO - 'LANG': 'en_US.UTF-8', 01:12:40 INFO - 'LANGUAGE': 'en_US:en', 01:12:40 INFO - 'LOGNAME': 'cltbld', 01:12:40 INFO - 'MAIL': '/var/mail/cltbld', 01:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:40 INFO - 'MOZ_NO_REMOTE': '1', 01:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:12:40 INFO - 'NO_EM_RESTART': '1', 01:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:40 INFO - 'PWD': '/builds/slave/test', 01:12:40 INFO - 'SHELL': '/bin/bash', 01:12:40 INFO - 'SHLVL': '1', 01:12:40 INFO - 'TERM': 'linux', 01:12:40 INFO - 'TMOUT': '86400', 01:12:40 INFO - 'USER': 'cltbld', 01:12:40 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', 01:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:40 INFO - '_': '/tools/buildbot/bin/python'} 01:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:12:40 INFO - Running setup.py (path:/tmp/pip-Y8ZZrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:12:40 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)) 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:12:40 INFO - Running setup.py (path:/tmp/pip-ZORSrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:12:40 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)) 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:12:40 INFO - Running setup.py (path:/tmp/pip-8bQNHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:12:40 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)) 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:12:40 INFO - Running setup.py (path:/tmp/pip-PK59EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:12:40 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)) 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:12:40 INFO - Running setup.py (path:/tmp/pip-ZJAL5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:12:40 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)) 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:12:40 INFO - Running setup.py (path:/tmp/pip-ahf1AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:12:40 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)) 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:12:40 INFO - Running setup.py (path:/tmp/pip-qyOXVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:12:40 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)) 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:12:40 INFO - Running setup.py (path:/tmp/pip-pQpJZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:12:40 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)) 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:12:40 INFO - Running setup.py (path:/tmp/pip-YTHTSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:12:40 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)) 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:12:40 INFO - Running setup.py (path:/tmp/pip-3hm_8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:12:40 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)) 01:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:12:40 INFO - Running setup.py (path:/tmp/pip-nzXe4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:12:41 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)) 01:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:12:41 INFO - Running setup.py (path:/tmp/pip-gwCEwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:12:41 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)) 01:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:12:41 INFO - Running setup.py (path:/tmp/pip-T75mJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:12:41 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)) 01:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:12:41 INFO - Running setup.py (path:/tmp/pip-yGiuMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:12:41 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)) 01:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:12:41 INFO - Running setup.py (path:/tmp/pip-1Ox61E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:12:41 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)) 01:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:12:41 INFO - Running setup.py (path:/tmp/pip-vCi6Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:12:41 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)) 01:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:12:41 INFO - Running setup.py (path:/tmp/pip-B3soT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:12:41 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)) 01:12:41 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)) 01:12:41 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)) 01:12:41 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)) 01:12:41 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)) 01:12:41 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)) 01:12:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:12:41 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 01:12:41 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 01:12:41 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 01:12:41 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 01:12:41 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 01:12:41 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 01:12:43 INFO - Downloading blessings-1.6.tar.gz 01:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:12:43 INFO - Installing collected packages: blessings 01:12:43 INFO - Running setup.py install for blessings 01:12:43 INFO - Successfully installed blessings 01:12:43 INFO - Cleaning up... 01:12:43 INFO - Return code: 0 01:12:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:12:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:12:43 INFO - Reading from file tmpfile_stdout 01:12:43 INFO - Current package versions: 01:12:43 INFO - argparse == 1.2.1 01:12:43 INFO - blessings == 1.6 01:12:43 INFO - blobuploader == 1.2.4 01:12:43 INFO - docopt == 0.6.1 01:12:43 INFO - manifestparser == 1.1 01:12:43 INFO - mozInstall == 1.12 01:12:43 INFO - mozcrash == 0.17 01:12:43 INFO - mozdebug == 0.1 01:12:43 INFO - mozdevice == 0.48 01:12:43 INFO - mozfile == 1.2 01:12:43 INFO - mozhttpd == 0.7 01:12:43 INFO - mozinfo == 0.9 01:12:43 INFO - mozleak == 0.1 01:12:43 INFO - mozlog == 3.1 01:12:43 INFO - moznetwork == 0.27 01:12:43 INFO - mozprocess == 0.22 01:12:43 INFO - mozprofile == 0.28 01:12:43 INFO - mozrunner == 6.11 01:12:43 INFO - mozscreenshot == 0.1 01:12:43 INFO - mozsystemmonitor == 0.0 01:12:43 INFO - moztest == 0.7 01:12:43 INFO - mozversion == 1.4 01:12:43 INFO - psutil == 3.1.1 01:12:43 INFO - requests == 1.2.3 01:12:43 INFO - wsgiref == 0.1.2 01:12:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:12:43 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')]} 01:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:43 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')]} 01:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:43 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 0x7f7c15bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05410>, '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 0x1b06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b067a0>, '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': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', '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 01:12:43 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 01:12:43 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 01:12:43 INFO - Using env: {'DISPLAY': ':0', 01:12:43 INFO - 'HOME': '/home/cltbld', 01:12:43 INFO - 'LANG': 'en_US.UTF-8', 01:12:43 INFO - 'LANGUAGE': 'en_US:en', 01:12:43 INFO - 'LOGNAME': 'cltbld', 01:12:43 INFO - 'MAIL': '/var/mail/cltbld', 01:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:43 INFO - 'MOZ_NO_REMOTE': '1', 01:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:12:43 INFO - 'NO_EM_RESTART': '1', 01:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:43 INFO - 'PWD': '/builds/slave/test', 01:12:43 INFO - 'SHELL': '/bin/bash', 01:12:43 INFO - 'SHLVL': '1', 01:12:43 INFO - 'TERM': 'linux', 01:12:43 INFO - 'TMOUT': '86400', 01:12:43 INFO - 'USER': 'cltbld', 01:12:43 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', 01:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:43 INFO - '_': '/tools/buildbot/bin/python'} 01:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:44 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)) 01:12:44 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)) 01:12:44 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)) 01:12:44 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)) 01:12:44 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)) 01:12:44 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)) 01:12:44 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)) 01:12:44 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)) 01:12:44 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)) 01:12:44 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)) 01:12:44 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)) 01:12:44 INFO - Cleaning up... 01:12:44 INFO - Return code: 0 01:12:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:12: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')]} 01:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12: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')]} 01:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c15bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05410>, '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 0x1b06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b067a0>, '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': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', '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 01:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:12:44 INFO - Using env: {'DISPLAY': ':0', 01:12:44 INFO - 'HOME': '/home/cltbld', 01:12:44 INFO - 'LANG': 'en_US.UTF-8', 01:12:44 INFO - 'LANGUAGE': 'en_US:en', 01:12:44 INFO - 'LOGNAME': 'cltbld', 01:12:44 INFO - 'MAIL': '/var/mail/cltbld', 01:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:44 INFO - 'MOZ_NO_REMOTE': '1', 01:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:12:44 INFO - 'NO_EM_RESTART': '1', 01:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:44 INFO - 'PWD': '/builds/slave/test', 01:12:44 INFO - 'SHELL': '/bin/bash', 01:12:44 INFO - 'SHLVL': '1', 01:12:44 INFO - 'TERM': 'linux', 01:12:44 INFO - 'TMOUT': '86400', 01:12:44 INFO - 'USER': 'cltbld', 01:12:44 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', 01:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:44 INFO - '_': '/tools/buildbot/bin/python'} 01:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:44 INFO - Downloading/unpacking jsonschema 01:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:12:46 INFO - Downloading/unpacking functools32 (from jsonschema) 01:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:46 INFO - Downloading functools32-3.2.3-2.tar.gz 01:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:12:46 INFO - warning: no files found matching '*.txt' 01:12:46 INFO - no previously-included directories found matching 'build' 01:12:46 INFO - no previously-included directories found matching 'dist' 01:12:46 INFO - no previously-included directories found matching '.git*' 01:12:46 INFO - Installing collected packages: jsonschema, functools32 01:12:46 INFO - Running setup.py install for functools32 01:12:46 INFO - warning: no files found matching '*.txt' 01:12:46 INFO - no previously-included directories found matching 'build' 01:12:46 INFO - no previously-included directories found matching 'dist' 01:12:46 INFO - no previously-included directories found matching '.git*' 01:12:46 INFO - Successfully installed jsonschema functools32 01:12:46 INFO - Cleaning up... 01:12:46 INFO - Return code: 0 01:12:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:46 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 0x7f7c15bebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05410>, '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 0x1b06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b067a0>, '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': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', '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 01:12:46 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 01:12:46 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 01:12:46 INFO - Using env: {'DISPLAY': ':0', 01:12:46 INFO - 'HOME': '/home/cltbld', 01:12:46 INFO - 'LANG': 'en_US.UTF-8', 01:12:46 INFO - 'LANGUAGE': 'en_US:en', 01:12:46 INFO - 'LOGNAME': 'cltbld', 01:12:46 INFO - 'MAIL': '/var/mail/cltbld', 01:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:46 INFO - 'MOZ_NO_REMOTE': '1', 01:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:12:46 INFO - 'NO_EM_RESTART': '1', 01:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:46 INFO - 'PWD': '/builds/slave/test', 01:12:46 INFO - 'SHELL': '/bin/bash', 01:12:46 INFO - 'SHLVL': '1', 01:12:46 INFO - 'TERM': 'linux', 01:12:46 INFO - 'TMOUT': '86400', 01:12:46 INFO - 'USER': 'cltbld', 01:12:46 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', 01:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:46 INFO - '_': '/tools/buildbot/bin/python'} 01:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:47 INFO - Downloading/unpacking flake8 01:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:12:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:12:49 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 01:12:49 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 01:12:49 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 01:12:49 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 01:12:49 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 01:12:49 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 01:12:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:12:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:12:49 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 01:12:49 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 01:12:49 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 01:12:49 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 01:12:49 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 01:12:49 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 01:12:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:12:50 INFO - no previously-included directories found matching 'docs/_build' 01:12:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:12:50 INFO - Running setup.py install for pep8 01:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:12:50 INFO - no previously-included directories found matching 'docs/_build' 01:12:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:12:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:12:50 INFO - Cleaning up... 01:12:50 INFO - Return code: 0 01:12:50 INFO - Running post-action listener: _resource_record_post_action 01:12:50 INFO - Running post-action listener: _start_resource_monitoring 01:12:50 INFO - Starting resource monitoring. 01:12:50 INFO - ##### 01:12:50 INFO - ##### Running install step. 01:12:50 INFO - ##### 01:12:50 INFO - Running pre-action listener: _resource_record_pre_action 01:12:50 INFO - Running main action method: install 01:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:12:50 INFO - Reading from file tmpfile_stdout 01:12:50 INFO - Detecting whether we're running mozinstall >=1.0... 01:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:12:50 INFO - Reading from file tmpfile_stdout 01:12:50 INFO - Output received: 01:12:50 INFO - Usage: mozinstall [options] installer 01:12:50 INFO - Options: 01:12:50 INFO - -h, --help show this help message and exit 01:12:50 INFO - -d DEST, --destination=DEST 01:12:50 INFO - Directory to install application into. [default: 01:12:50 INFO - "/builds/slave/test"] 01:12:50 INFO - --app=APP Application being installed. [default: firefox] 01:12:50 INFO - mkdir: /builds/slave/test/build/application 01:12:50 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'] 01:12:50 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 01:13:06 INFO - Reading from file tmpfile_stdout 01:13:06 INFO - Output received: 01:13:06 INFO - /builds/slave/test/build/application/firefox/firefox 01:13:06 INFO - Running post-action listener: _resource_record_post_action 01:13:06 INFO - ##### 01:13:06 INFO - ##### Running run-tests step. 01:13:06 INFO - ##### 01:13:06 INFO - Running pre-action listener: _resource_record_pre_action 01:13:06 INFO - Running main action method: run_tests 01:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:13:06 INFO - Python 2.7.3 01:13:06 INFO - Return code: 0 01:13:06 INFO - grabbing minidump binary from tooltool 01:13:06 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')]} 01:13:06 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 0x1b05410>, '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 0x1b06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b067a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:13:06 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 01:13:06 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 01:13:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:13:06 INFO - Return code: 0 01:13:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:13:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:13:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:13:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:13:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:13:07 INFO - Return code: 0 01:13:07 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/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 01:13:07 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/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 01:13:07 INFO - Using env: {'DISPLAY': ':0', 01:13:07 INFO - 'HOME': '/home/cltbld', 01:13:07 INFO - 'LANG': 'en_US.UTF-8', 01:13:07 INFO - 'LANGUAGE': 'en_US:en', 01:13:07 INFO - 'LOGNAME': 'cltbld', 01:13:07 INFO - 'MAIL': '/var/mail/cltbld', 01:13:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:13:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:07 INFO - 'MOZ_NO_REMOTE': '1', 01:13:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:07 INFO - 'NO_EM_RESTART': '1', 01:13:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:07 INFO - 'PWD': '/builds/slave/test', 01:13:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:13:07 INFO - 'SHELL': '/bin/bash', 01:13:07 INFO - 'SHLVL': '1', 01:13:07 INFO - 'TERM': 'linux', 01:13:07 INFO - 'TMOUT': '86400', 01:13:07 INFO - 'USER': 'cltbld', 01:13:07 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681', 01:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:07 INFO - '_': '/tools/buildbot/bin/python'} 01:13:07 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/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 01:13:07 INFO - mozversion application_buildid: 20160405002006 01:13:07 INFO - mozversion application_changeset: ff96d9731ec72261815762f219cfafc7ff5b9495 01:13:07 INFO - mozversion application_display_name: Nightly 01:13:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:13:07 INFO - mozversion application_name: Firefox 01:13:07 INFO - mozversion application_remotingname: firefox 01:13:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:13:07 INFO - mozversion application_vendor: Mozilla 01:13:07 INFO - mozversion application_version: 48.0a1 01:13:07 INFO - mozversion platform_buildid: 20160405002006 01:13:07 INFO - mozversion platform_changeset: ff96d9731ec72261815762f219cfafc7ff5b9495 01:13:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:13:07 INFO - mozversion platform_version: 48.0a1 01:13:07 INFO - using testdate: 1459843987 01:13:07 INFO - actual date: 1459843987 01:13:07 INFO - starting webserver on 'localhost:34773' 01:13:07 INFO - SUITE-START | Running 2 tests 01:13:07 INFO - TEST-START | dromaeo_css 01:13:07 INFO - operating with platform_type : linux_ 01:13:07 INFO - Initialising browser for dromaeo_css test... 01:13:07 INFO - TEST-INFO | started process 16458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT0Xfxh/profile http://localhost:34773/getInfo.html) 01:13:12 INFO - PROCESS | 16458 | __metrics Screen width/height:1600/1200 01:13:12 INFO - PROCESS | 16458 | colorDepth:24 01:13:12 INFO - PROCESS | 16458 | Browser inner width/height: 1024/697 01:13:12 INFO - PROCESS | 16458 | __metrics 01:13:12 ERROR - PROCESS | 16458 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:13:13 INFO - TEST-INFO | 16458: exit 0 01:13:13 INFO - Browser initialized. 01:13:13 INFO - Running cycle 1/1 for dromaeo_css test... 01:13:13 INFO - TEST-INFO | started process 16536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT0Xfxh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:13:25 INFO - PROCESS | 16536 | RSS: Main: 153833472 01:13:25 INFO - PROCESS | 16536 | 01:14:16 INFO - PROCESS | 16536 | 1459844056753 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] 01:16:27 INFO - PROCESS | 16536 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34773/tests/dromaeo/cssquery-ext.html) 01:16:28 INFO - PROCESS | 16536 | RSS: Main: 232280064 01:16:28 INFO - PROCESS | 16536 | 01:19:30 INFO - PROCESS | 16536 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-ext.html (next: http://localhost:34773/tests/dromaeo/cssquery-jquery.html) 01:19:31 INFO - PROCESS | 16536 | RSS: Main: 233558016 01:19:31 INFO - PROCESS | 16536 | 01:22:33 INFO - PROCESS | 16536 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34773/tests/dromaeo/cssquery-mootools.html) 01:22:33 INFO - PROCESS | 16536 | RSS: Main: 233721856 01:22:33 INFO - PROCESS | 16536 | 01:25:35 INFO - PROCESS | 16536 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34773/tests/dromaeo/cssquery-prototype.html) 01:25:36 INFO - PROCESS | 16536 | RSS: Main: 222662656 01:25:36 INFO - PROCESS | 16536 | 01:28:39 INFO - PROCESS | 16536 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34773/tests/dromaeo/cssquery-yui.html) 01:28:39 INFO - PROCESS | 16536 | RSS: Main: 201486336 01:28:39 INFO - PROCESS | 16536 | 01:31:42 INFO - PROCESS | 16536 | Cycle 1(1): loaded http://localhost:34773/tests/dromaeo/cssquery-yui.html (next: http://localhost:34773/tests/dromaeo/cssquery-dojo.html) 01:31:42 INFO - PROCESS | 16536 | RSS: Main: 265494528 01:31:42 INFO - PROCESS | 16536 | 01:31:42 INFO - PROCESS | 16536 | __start_tp_report 01:31:42 INFO - PROCESS | 16536 | _x_x_mozilla_page_load 01:31:42 INFO - PROCESS | 16536 | _x_x_mozilla_page_load_details 01:31:42 INFO - PROCESS | 16536 | |i|pagename|runs| 01:31:42 INFO - PROCESS | 16536 | |0;dojo.html;2585.586306191009;2664.440467501823;2674.598810178472;2682.825616334938;2704.553748631475;4501.7524036178;4563.338315944195;4563.589276965073;4577.198990176722;4592.632589392849;4569.063342014887;4593.494715581283;4597.172508948388;4658.604018658418;4674;4189.706720529556;4199.7480151190875;4204.957950420502;4229.513605935311;4340.826366945318;4303.182395344875;4316.223079845627;4338.089001309729;4369.410129632491;4372.3878656988045;4155.293600087993;4196.685248606336;4249.702520823544;4266.040140968273;4274.316109422478;4247.193033323659;4262.680298977558;4263.317869140954;4303.203907277132;4306.052668412975;4239.618434340893;4241.660667146621;4253.1706317268145;4286.635635970915;4287;4386.188555117282;4463.709858859196;4501.347304640842;4556.316552517116;4572.039871626962;4900.338454308659;4904.068227036852;4924.3105965164905;4927;4977.477364876672;4940.135476291634;4947;4949.529794669501;4950.4801995790285;5000.549950504472;4506.729596224204;4571.885702857388;4620.722756634613;4645.837395691135;4659.044895796354;5018.749062546858;5031.723255220998;5041.01700168471;5050.339974347191;5073.695578265316;4708.411448568929;4836.274558816135;4837.201861692852;4837.588804951548;4877;4837.443693975168;4873.390826146731;4913.164761990399;4914.926276105862;4922.8769280768265;4772.427308722976;4787.8563643090765;4790.065937142223;4797.928031079537;4841.273808928619;4698.2952557116705;4770.499097594772;4775.379200703956;4782.067496838084;4829.806807727722;4064.6545043671617;4119.032027473541;4120.835166593302;4154.854580089743;4161.812718427678;3607.026102952188;3619.1675914539805;3624.293262813726;3653.2328211075974;3658.5243918290985;4222.134462435193;4285.400043993844;4286.357046443059;4289.935650965238;4301.2257793597455;4864.440589332201;4921.040397122527;4922.852314430573;4927.876803079952;4969.0310389474425;4256.106217694257;4260.616544511009;4285.309287323629;4307;4325.675574331937;4281;4320.265554855682;4354.303311470149;4407.691461597721;4493.842715504941;4710.882227944328;4717.221658426459;4719.693219940624;4739.478657347689;4746.311784791255;4974.527419895104;4987.80048798044;4989.276554899592;4991.725455099859;5035.823746168867;4584.724916504887;4681.485036646034;4712.175369310288;4758.2386818108935;4767.499412561631;4877.707337559757;4878.487758785276;4900.4854490278;4903.092927808367;4947.109520286383;4943.134951383421;4956.950430495649;4961.131801934719;4967.801287948441;5010.724410157476;4682.2508398656055;4714.905701885875;4769.499202583679;4790;4823.397075365579;4745.074710431432;4762.928556071731;4783.593394561502;4786.0667169901535;4824.8793780155775;4643.605293550086;4738.123447162286;4754.477007529238;4755.089058524096;4813.975930120327;4795.904081918412;4839.516048395132;4841.394825646794;4869.9026019480125;4893.09477746618;4668.673192876466;4716.693414928019;4722.197226471577;4722.268048452495;4764.714117152982 01:31:42 INFO - PROCESS | 16536 | |1;ext.html;540.5486418840269;553.8781468077021;559.7900787204799;567.6452217364148;577.745791851585;27955.301117472074;28296.43407131859;36414.635853641455;36544;36547.451788223196;39392;39977.80011099941;39993.800030999875;40011.999100067536;40021.799891000504;7564.432667549928;7741.57421341826;7745.7676269712;7748.651310691004;7749.30256276935;7862.449628526006;7998.440109192359;8015.639296231654;8015.839683206333;8016.599170041474;7967.402444816633;8083.151269116746;8084.636191371403;8084.71703490378;8085.029796424408;7895.565743884084;7938.126806051329;7950.244726751007;7975.32209762168;8021.799455013613;7864.4888082274465;8025.398095142829;8025.3980951428875;8028.438009339348;8029.638666259974;38484.42273365902;38942.610573894184;38954.22091558181;39074.60925390738;39108.60891391078;3249.820691019721;3326.9500957485416;3392.525046493493;3673.651003154696;3785.1861849702173;27904.860475697493;29515.409691806257;29860.701392986226;30193.09420717382;30690.23274418135;3483.2685136121445;3545.1137215696076;3553.662402071825;3593.7843729376323;3635.309291234657;244931;245355;246012;246914;247078;57018.71490642603;57163;57572;57623.847523049306;57653.42346576564;53845.73077134667;60723.392766071775;60955.39044609497;63980.360196398375;65211.67394162999;15000.924995374953;15644.843551564567;15661.921690391702;15679.137647429501;15694.293756780973;11430.085593152528;11691.88308116925;11695.415229238504;11697.532098716127;11703.941480292544;17415.216315265843;19726.40820775379;19733.013349332763;21049.473763156042;21190.682139767916;7434.219406962299;7480.803071508642;7601.429892758065;7647.273509016746;7650.579218143055;940.7318914109446;947.8341290274175;956.5217391304348;963.0706368354571;977.1352353167498;25207.87396063008;25911.22266332013;25936.092236771623;26135.869320653273;26241.34396640061;919.544825311475;997.5710444508786;998.7403275148514;1021.6985989133224;1082.5453309609982;13598.504164541893;13924.930375348058;14205.928970355082;14209.431622734975;14228.296623641476;291397;295071;295296;297606;298075;49243.50756492461;49510.257346139835;49511;49542;49600.751996239786;1072.265498133781;1210.0924306769923;1246.1339369138543;1249.3940438887314;1269.9492020319083;25666.358341041625;26752.8662356687;26759.19722408331;26970.460590788465;27222.183334499998;38543.614563854004;44463.55536444594;45083.54916450794;45099.549004510845;45113.0977380444;181794;182668;183668;183711;183840;30264.394712106074;30711;30762.538561922036;30763;30764.538531922488;38720.2255954885;40223.1955360897;40583.39124913188;42380.36429453499;43472.78263608662;36279.455808163424;36497.45253821248;36523.26953460969;36613.63386366102;36865.44701829529;35241.47137792986;35376.46935295921;35443.291134177685;35529.289414212086;35589.28821423609;34661.30677386488;35212.823935881184;35241.118972025906;35639;36007;31744.04767856968;31747.085877408466;32095.35809283848;32123.357532848746;32124.03627891167;25117.87441062783;25142.62286065674;25305.367365816;25511.36221594475;25573.232803015195 01:31:42 INFO - PROCESS | 16536 | |2;jquery.html;346.5512161750534;350.8333541567755;359.7553663508814;363.7926381962279;367.15187915914225;15360.692786144284;15579.688406231882;15602.921985390072;15805.051696898165;15912.76130858038;15167.241637918116;15349.616259593487;16091.597710057255;16142.950708203958;16161.676766464663;4875.70745755254;5078.5937125029905;5078.796848126089;5083.974580127094;5186.818461353853;5329.360476742796;5338.065838478251;5349.197620356938;5371.409144994048;5374.193870919374;5258.815941442051;5339.39818054584;5354.41101478837;5356.303680521527;5366.034113859504;5302.6023048271345;5323.707196104213;5401.27082843815;5432.130859062531;5445.292112025451;5218.086834803894;5232.764525596357;5309.5752339812725;5316.627836051478;5318.042752304584;16917.407890723767;19171.32900348481;19635.116419761;19642.214311427524;19649.312274070482;1885.8774179678278;2031.9796802031938;2079.781622929601;2423.369923819802;2432.513497300547;9209.171174594252;9708.805823883553;9900.80198396028;10293.691189264335;13079.542216022488;1780.1188411736273;1793.3543924187281;1794.1836464408664;1804.3865085870736;1836.2471386731509;41717;44463;54499.91000180014;60399;61280.387196127915;9322.927863295672;9551.235901127893;9609.327347085637;9762.609495620096;9849.261305402124;13378.13042152257;13434.596962091153;13449.865501345057;13533.39099740514;13556.728865422636;6506.3493650634555;6981.616011119438;6988.545744526589;7169.354758071694;7193.89209161863;6756.425703815231;6776.69504872282;6852.28051054642;6865.41643960269;6870.725170993104;4141.088960428761;4175.791210439465;4198.769067701306;4263.381809637585;4265.274903266452;1724.2758041622549;1742.1637613945377;1778.0931724820175;1787.6067265201634;1821.3625231169249;833.9791505212297;851.1105894340305;862.8446879561614;867.8481265778463;879.4855009819328;15592.844071559366;15930.522084337488;16206.108664023592;16327.510174694778;16641.50075497713;851.4550687559843;867.3451544084176;870.2037635563515;898.820235952799;899.2670973156987;8873.911260887438;9223.861642075375;9337.066293370744;9528.428294302365;9640.373375730554;416723;420617;427549;432384;435189;70864.64567677231;72323.63838180776;72703.2729672707;73071.26928730751;74467.62766186243;938.638624129715;940.3182692547848;962.8940816510178;965.1072757699101;972.4894430424084;15144.772828407362;15193.316300766272;15300.693986119993;15307.234638267819;15397.153156576047;33204.50193247152;34254.657453426145;34646.13384665403;34764;34975;47638.523614763406;48489.5151048485;48583.27125093056;48633.756831215615;48979.75510122427;7776.611169441619;7799.805004874924;7808.648610812641;7867.763967080997;7946.125926148235;10649.840252396065;11803.704907377385;11913.166078374777;11945.761084778429;12099.57651482194;10227;10305.587776488857;10369.585216591251;10508.947455262674;10571.154307655523;10008.949955250177;10147.695569132939;10171.389716617026;10212.693619191436;10327.586896524055;10164;10437.478126093512;10566.630167944393;10593.682189534018;10768.3538987661;7321.560706357635;7476.25237476248;7612.086549614081;7643.7324693635455;7645.923540764521;9432.292578056537;10072.84890726625;10326.741831454274;10328.328658637165;10362.222833287382 01:31:42 INFO - PROCESS | 16536 | |3;mootools.html;1282.0640932119559;1362.0805955979715;1390.158953832931;1492.410497853348;1712.8287171282882;6376.585521941076;6694.6987385567645;6797;6802.7619033333785;6804.931950680504;6939.27137650547;7082.504224704273;7085.2560481149385;7087.362137407632;7087.787366379017;1874.5594785225462;2140.6039882621685;2155.3426205007468;2177.629802933501;2204.239537359608;2129.084493667722;2169.4684802223396;2170.967435488469;2173.7282839645045;2174.8695078295355;2096.3186964236606;2097.1192099318323;2103.737032870891;2104.2109209046607;2105.1368938735122;2075.989620051905;2091.393495886191;2103.5161912760072;2106.662933930579;2123.830093592509;2132.1364847236896;2150.677398390254;2161.0815403453626;2164.7402311722694;2167.945801354963;6949.548279361826;6971.5468494547695;6996.195437524699;7009.824754381181;7019.473539484559;4438.755868427235;4549.135664223787;4555.385023021916;4556.088782243532;4562.703424277412;2842;2901.956470652942;2928.9707102929124;2949.823010619348;2954;915.9862602060974;917.921976631987;954.2413781044087;962.1100482054142;979.4906648542789;9609.039096090404;9652.710418687451;9653;9655.03449655036;9660.806783864353;3995.20095980805;4082.510098788164;4153.439285696392;4178.39413285072;4179.937300940488;8417.957910210409;8477.448965817202;8501.489910605384;8506.31949444043;8515.361347898932;3840.02079469739;4591.288350305708;4591.517890621503;4595.563421474954;4597.908041839144;4062.6343629072935;4113;4116.567760385176;4131.50421949368;4133.441985331941;3397.96362109554;3477.669621386015;3511.4206155983975;3532.3465158945164;3534.505169276303;1133.2916926920675;1171.8769529199483;1173.0674114079327;1179.3985067615579;1189.52419032386;980.2941881845203;1018.2668478695327;1167.7606090751376;1173.530587764901;1184.3841202574786;6620.040094186316;6693.564918280296;6707.094542236736;6707.295733947963;6717.16035495563;1091.0889407344798;1098.3355070182583;1111.5942680921567;1122.825961975895;1143.9256448330832;5233.371995360505;5270.92093618596;5346.331708536433;5355.437679043722;5355.785768569292;8303.8339233215;8456.196661317164;8479.06730259671;8534.061253262136;8536.317094632415;8270.710525131592;8360.665573376997;8443.366747493963;8489.066202717697;8731.825363492822;6884.793456196322;6943.132108486439;6972.302769722987;6998.090248267693;7035.788926332219;6530.8367290818105;6565.967170164118;6594.637294948824;6605.669716514059;6620.90068648961;7536.849263014599;7806.531608103532;7839.882401763864;8005.679772809022;8025.478343907627;7784.727534536264;7906.960465197637;8024.679012839421;8041.557714325534;8153.6738530458115;5299.735013249399;5819.5053420459735;5966.67183304905;6016.789412370546;6139.77204559081;6698.799036028927;6701.497387696039;6714.832129196614;6740.730370785113;6751.628660423724;5971.223740913827;6045.969770151297;6140.447359737466;6142.600730952474;6150.323464419;6101.328853826164;6170.9074363885475;6198.101275315144;6262.09199666055;6277.466415354746;6482.902756458751;6552.541322107407;6561.901571476527;6565.573237739532;6579.078928950046;5968.4926781224085;5970.492508136857;6025.6083354581815;6029.638221706711;6061.545384096122;6118.051701986199;6235.719392627252;6238.812835614939;6246.812595622138;6253.218347706536 01:31:42 INFO - PROCESS | 16536 | |4;prototype.html;307.448130605563;313.6847468294364;317.60458229504263;322.3247296912966;323.2677984365411;5197.584193264539;5274.340707411574;5286.259923610698;5310.814121505743;5333.466653334664;5236.659617124894;5245.659032162906;5251.658642188255;5255.684658920468;5264.052470555299;3919.5884432134644;4022.839086436539;4100.200460910109;4132.669386449077;4135.27632664284;4106.342985122381;4106.363513655373;4113.794310284488;4128.731632443882;4128.97935510322;4051.898702532431;4071.857484988026;4083.3262511685684;4086.652634526054;4096.8975775605695;3889.961100388988;4000.679945604359;4074.816633251481;4078.714489985702;4106.958930410688;3621.0947263184203;3633.6003039665616;3635.836387362575;3637.7089832813576;3640.5631324240994;5013.373328333958;5014.172661510846;5021.472745361758;5023.196288593807;5024.819167495635;4705.929411058837;4710.717356958594;4715.245560710304;4720.716756994591;4729.62163026957;5485.040117979377;5510.401983424802;5520.171974203901;5520.889582208333;5522.502974732293;3975.940360894589;3976.3836605325932;3982.3230050891416;3985.6612187964056;3986.063275130342;5502.697351645658;5694.544436445074;5701.372848986608;5705.686187259699;5809.564282678816;3886.7862267574988;3921.568627450978;3924.7448915820382;3927.2930872443235;3934.842606295716;3984.2828290907914;3985.5217373915316;3986.980065099714;3988.062805240766;3989.2221016901426;4594.2419500782;4598.471175814757;4602.631789456836;4604.102200071021;4604.263317869125;5533.723313834292;5535.640183388067;5547.944520554743;5554.50009499147;5555.694436805934;1389.673426744714;1408.1621435246218;1409.584172669065;1411.7999700254907;1411.8799902008445;895.6686026170229;922.294444749767;935.7520257131865;939.4691999020669;957.2912351452624;4828.734419606885;4832.4684284728655;4838.782254798542;4855.587275081658;4858.101251268456;5628.437156284421;5630.859228519238;5688.516476099578;5692;5694.60137790359;4869.147899117711;4870.464248932614;4879.487653796371;4880.487548807324;4889.462159162489;3033.0445909538425;3074.969250307513;3086.3364376659124;3088.722015018659;3093.072078376523;5388.272583201296;5393.056215162331;5396.703181324986;5402.405735369106;5404.32445944257;5630.071038278638;5799.594028418054;5803.47768700819;5809.215755872988;5816.738246778905;5365.9731701342025;5386.5152136307925;5394.757235924393;5395.244665746799;5400.891982160413;5668.688222147822;5682.232898558642;5683.8863222736145;5687.232223649754;5687.402822703557;5553.750081246434;5555.694436806015;5555.72221388937;5559.861003474945;5565.610407271614;5365.490278423544;5376.838694839161;5378.542823860016;5386.676799392049;5393;3840.327942609976;3946.565877753387;3951.407288906687;3956.7823769692945;3967.464392307117;5617.662940223599;5617.775288988395;5630.23991761107;5633.6619802811965;5653.462921022497;5452.972735136299;5459;5460.726963651722;5461.481159289861;5465.316835395575;5407.080796264566;5440.945590544044;5443.319585051869;5454.8909021818545;5465.754041068082;5358.678479291255;5385.75764090609;5390.946090539202;5392.433794451526;5398.811041613525;5350.117230657053;5505.064139096283;5509.641873278384;5509.889802204014;5517.641353312022;5337.546308563816;5341.608078870023;5371.140617501337;5375.704336261543;5376.193570964387 01:31:42 INFO - PROCESS | 16536 | |5;yui.html;598.4315940176656;700.8458139209374;740.7703611880314;742.7920182348944;754.0574282147315;11766.235194712337;12480.750384992294;12586.874131258684;12634.684132896682;12645.430955606997;11920.046396288299;11974.34141122238;12007.399630018508;12010.21933574317;12097.939510302458;651.0332156747227;812.8252425728467;813.2802469814227;817.791463176889;830.8919840420737;835.9498430094184;835.995820020899;836.2515548584014;838.5597561280316;839.7019058234331;872.3283072034561;874.6894852327428;876.1895246896627;876.5135349880813;876.8947726272856;668.9598624082546;678.2945736434078;864.3517361978517;865.2342676731075;884.920357167858;621.1304174156172;621.4034526854225;621.9036049412348;622.2719418280623;622.6699849079995;12455.252684838939;12468.501259949591;12490.75018499634;12495.937520312431;12497.312647804367;12106.939465302705;12431.875681243162;12446.564370246997;12612.011629296261;12804.231746095264;11249.83125253122;11257.380844053574;11381.700830693802;11398.316101033965;11751.353675547842;3326;3355.463125899869;3378.7297016238886;3394.728421726256;3444.431668774649;42695;42838;42927.35608965868;43075.569244307786;43438.13123737539;10290.536925838354;10449.634262800766;10487.26589138753;10554.10290125348;10581.84127238092;18078.90960545189;18156;18291.1768970394;18346.724799128024;18368;6832.385085342343;6851.931480685229;6923.9307606923285;6982;6995.160580730345;3818.961810381916;3822.8470861165797;3823.1589050408866;3840.7503512271614;3849.6535311821513;2805.677347105109;2816.971830281712;2817.690054094048;2838.1485554333617;2839.673437554666;495.2496967094854;518.4918779595941;533.8265063854263;538.8388023808699;543.228615366181;524.0645447875523;535.5902734408181;590.539379284159;593.5162842283526;607.2106261859565;7992.240737129963;8004.159563245892;8264.752057438287;8291.170882911782;8316.958415207886;599.8350453625201;605.4339192854695;619.8729260501586;632.9303776584665;639.341478277375;3743.401055831054;3864.2078373933837;3899.1811719539214;3917.980410097988;3945.8027098644952;47496.5250347499;50453.74773126111;53805;55356.72321638366;55546.444535554125;44655.77672111684;45304.77347613241;45533.54466455359;45719.771401143444;46454.76772616183;39976.200475990314;40438.39342409925;40510.1897962045;40676.389854152214;40934.38598421026;8171;8227.917720822716;8404.033536143177;8409.705660301861;8573.356998225034;30614;30792.84603576968;31671.258080804855;31684;31751.523727144573;38610.613893861824;40229.1954160921;40460.79769601133;40524;40813.591864080976;9920.52101788537;10030;10275.126614237874;10485.108765754996;10512.053915147673;10828;11009.229353945148;11129.777404451703;11234.382108984084;11444.713882153013;10112.59549618007;10185.898141018792;10289.279750417698;10363.792724145625;10406;10671.893281067401;10679.038886500251;10781.892181078403;10788.083012943987;10893;10279.588816447258;10368.688939331832;10625.203109766953;10625.628103016667;10699.679009629723;8857;8920.687775927812;8944.776380590278;8993.235574975939;9269;8750.562471876508;9131.406458580172;9142.817143657223;9212.170904618617;9370.812583748151 01:31:42 INFO - PROCESS | 16536 | __end_tp_report 01:31:42 INFO - PROCESS | 16536 | __start_cc_report 01:31:42 INFO - PROCESS | 16536 | _x_x_mozilla_cycle_collect,828 01:31:42 INFO - PROCESS | 16536 | __end_cc_report 01:31:42 INFO - PROCESS | 16536 | __startTimestamp1459845102369__endTimestamp 01:31:42 INFO - PROCESS | 16536 | 01:31:42 INFO - PROCESS | 16536 | ------- Summary: start ------- 01:31:42 INFO - PROCESS | 16536 | Number of tests: 6 01:31:42 INFO - PROCESS | 16536 | 01:31:42 INFO - PROCESS | 16536 | [#0] dojo.html Cycles:165 Average:4552.57 Median:4710.88 stddev:462.57 (9.8%) stddev-sans-first:437.50 01:31:42 INFO - PROCESS | 16536 | Values: 2585.6 2664.4 2674.6 2682.8 2704.6 4501.8 4563.3 4563.6 4577.2 4592.6 4569.1 4593.5 4597.2 4658.6 4674.0 4189.7 4199.7 4205.0 4229.5 4340.8 4303.2 4316.2 4338.1 4369.4 4372.4 4155.3 4196.7 4249.7 4266.0 4274.3 4247.2 4262.7 4263.3 4303.2 4306.1 4239.6 4241.7 4253.2 4286.6 4287.0 4386.2 4463.7 4501.3 4556.3 4572.0 4900.3 4904.1 4924.3 4927.0 4977.5 4940.1 4947.0 4949.5 4950.5 5000.5 4506.7 4571.9 4620.7 4645.8 4659.0 5018.7 5031.7 5041.0 5050.3 5073.7 4708.4 4836.3 4837.2 4837.6 4877.0 4837.4 4873.4 4913.2 4914.9 4922.9 4772.4 4787.9 4790.1 4797.9 4841.3 4698.3 4770.5 4775.4 4782.1 4829.8 4064.7 4119.0 4120.8 4154.9 4161.8 3607.0 3619.2 3624.3 3653.2 3658.5 4222.1 4285.4 4286.4 4289.9 4301.2 4864.4 4921.0 4922.9 4927.9 4969.0 4256.1 4260.6 4285.3 4307.0 4325.7 4281.0 4320.3 4354.3 4407.7 4493.8 4710.9 4717.2 4719.7 4739.5 4746.3 4974.5 4987.8 4989.3 4991.7 5035.8 4584.7 4681.5 4712.2 4758.2 4767.5 4877.7 4878.5 4900.5 4903.1 4947.1 4943.1 4957.0 4961.1 4967.8 5010.7 4682.3 4714.9 4769.5 4790.0 4823.4 4745.1 4762.9 4783.6 4786.1 4824.9 4643.6 4738.1 4754.5 4755.1 4814.0 4795.9 4839.5 4841.4 4869.9 4893.1 4668.7 4716.7 4722.2 4722.3 4764.7 01:31:42 INFO - PROCESS | 16536 | 01:31:42 INFO - PROCESS | 16536 | [#1] ext.html Cycles:180 Average:41271.21 Median:36143.23 stddev:64179.01 (177.6%) stddev-sans-first:64286.18 01:31:42 INFO - PROCESS | 16536 | Values: 540.5 553.9 559.8 567.6 577.7 27955.3 28296.4 36414.6 36544.0 36547.5 39392.0 39977.8 39993.8 40012.0 40021.8 7564.4 7741.6 7745.8 7748.7 7749.3 7862.4 7998.4 8015.6 8015.8 8016.6 7967.4 8083.2 8084.6 8084.7 8085.0 7895.6 7938.1 7950.2 7975.3 8021.8 7864.5 8025.4 8025.4 8028.4 8029.6 38484.4 38942.6 38954.2 39074.6 39108.6 3249.8 3327.0 3392.5 3673.7 3785.2 27904.9 29515.4 29860.7 30193.1 30690.2 3483.3 3545.1 3553.7 3593.8 3635.3 244931.0 245355.0 246012.0 246914.0 247078.0 57018.7 57163.0 57572.0 57623.8 57653.4 53845.7 60723.4 60955.4 63980.4 65211.7 15000.9 15644.8 15661.9 15679.1 15694.3 11430.1 11691.9 11695.4 11697.5 11703.9 17415.2 19726.4 19733.0 21049.5 21190.7 7434.2 7480.8 7601.4 7647.3 7650.6 940.7 947.8 956.5 963.1 977.1 25207.9 25911.2 25936.1 26135.9 26241.3 919.5 997.6 998.7 1021.7 1082.5 13598.5 13924.9 14205.9 14209.4 14228.3 291397.0 295071.0 295296.0 297606.0 298075.0 49243.5 49510.3 49511.0 49542.0 49600.8 1072.3 1210.1 1246.1 1249.4 1269.9 25666.4 26752.9 26759.2 26970.5 27222.2 38543.6 44463.6 45083.5 45099.5 45113.1 181794.0 182668.0 183668.0 183711.0 183840.0 30264.4 30711.0 30762.5 30763.0 30764.5 38720.2 40223.2 40583.4 42380.4 43472.8 36279.5 36497.5 36523.3 36613.6 36865.4 35241.5 35376.5 35443.3 35529.3 35589.3 34661.3 35212.8 35241.1 35639.0 36007.0 31744.0 31747.1 32095.4 32123.4 32124.0 25117.9 25142.6 25305.4 25511.4 25573.2 01:31:42 INFO - PROCESS | 16536 | 01:31:42 INFO - PROCESS | 16536 | [#2] jquery.html Cycles:180 Average:24461.79 Median:433786.50 stddev:69876.88 (16.1%) stddev-sans-first:70049.44 01:31:42 INFO - PROCESS | 16536 | Values: 346.6 350.8 359.8 363.8 367.2 15360.7 15579.7 15602.9 15805.1 15912.8 15167.2 15349.6 16091.6 16143.0 16161.7 4875.7 5078.6 5078.8 5084.0 5186.8 5329.4 5338.1 5349.2 5371.4 5374.2 5258.8 5339.4 5354.4 5356.3 5366.0 5302.6 5323.7 5401.3 5432.1 5445.3 5218.1 5232.8 5309.6 5316.6 5318.0 16917.4 19171.3 19635.1 19642.2 19649.3 1885.9 2032.0 2079.8 2423.4 2432.5 9209.2 9708.8 9900.8 10293.7 13079.5 1780.1 1793.4 1794.2 1804.4 1836.2 41717.0 44463.0 54499.9 60399.0 61280.4 9322.9 9551.2 9609.3 9762.6 9849.3 13378.1 13434.6 13449.9 13533.4 13556.7 6506.3 6981.6 6988.5 7169.4 7193.9 6756.4 6776.7 6852.3 6865.4 6870.7 4141.1 4175.8 4198.8 4263.4 4265.3 1724.3 1742.2 1778.1 1787.6 1821.4 834.0 851.1 862.8 867.8 879.5 15592.8 15930.5 16206.1 16327.5 16641.5 851.5 867.3 870.2 898.8 899.3 8873.9 9223.9 9337.1 9528.4 9640.4 416723.0 420617.0 427549.0 432384.0 435189.0 70864.6 72323.6 72703.3 73071.3 74467.6 938.6 940.3 962.9 965.1 972.5 15144.8 15193.3 15300.7 15307.2 15397.2 33204.5 34254.7 34646.1 34764.0 34975.0 47638.5 48489.5 48583.3 48633.8 48979.8 7776.6 7799.8 7808.6 7867.8 7946.1 10649.8 11803.7 11913.2 11945.8 12099.6 10227.0 10305.6 10369.6 10508.9 10571.2 10008.9 10147.7 10171.4 10212.7 10327.6 10164.0 10437.5 10566.6 10593.7 10768.4 7321.6 7476.3 7612.1 7643.7 7645.9 9432.3 10072.8 10326.7 10328.3 10362.2 01:31:42 INFO - PROCESS | 16536 | 01:31:42 INFO - PROCESS | 16536 | [#3] mootools.html Cycles:180 Average:5023.13 Median:6109.69 stddev:2538.12 (41.5%) stddev-sans-first:2529.66 01:31:42 INFO - PROCESS | 16536 | Values: 1282.1 1362.1 1390.2 1492.4 1712.8 6376.6 6694.7 6797.0 6802.8 6804.9 6939.3 7082.5 7085.3 7087.4 7087.8 1874.6 2140.6 2155.3 2177.6 2204.2 2129.1 2169.5 2171.0 2173.7 2174.9 2096.3 2097.1 2103.7 2104.2 2105.1 2076.0 2091.4 2103.5 2106.7 2123.8 2132.1 2150.7 2161.1 2164.7 2167.9 6949.5 6971.5 6996.2 7009.8 7019.5 4438.8 4549.1 4555.4 4556.1 4562.7 2842.0 2902.0 2929.0 2949.8 2954.0 916.0 917.9 954.2 962.1 979.5 9609.0 9652.7 9653.0 9655.0 9660.8 3995.2 4082.5 4153.4 4178.4 4179.9 8418.0 8477.4 8501.5 8506.3 8515.4 3840.0 4591.3 4591.5 4595.6 4597.9 4062.6 4113.0 4116.6 4131.5 4133.4 3398.0 3477.7 3511.4 3532.3 3534.5 1133.3 1171.9 1173.1 1179.4 1189.5 980.3 1018.3 1167.8 1173.5 1184.4 6620.0 6693.6 6707.1 6707.3 6717.2 1091.1 1098.3 1111.6 1122.8 1143.9 5233.4 5270.9 5346.3 5355.4 5355.8 8303.8 8456.2 8479.1 8534.1 8536.3 8270.7 8360.7 8443.4 8489.1 8731.8 6884.8 6943.1 6972.3 6998.1 7035.8 6530.8 6566.0 6594.6 6605.7 6620.9 7536.8 7806.5 7839.9 8005.7 8025.5 7784.7 7907.0 8024.7 8041.6 8153.7 5299.7 5819.5 5966.7 6016.8 6139.8 6698.8 6701.5 6714.8 6740.7 6751.6 5971.2 6046.0 6140.4 6142.6 6150.3 6101.3 6170.9 6198.1 6262.1 6277.5 6482.9 6552.5 6561.9 6565.6 6579.1 5968.5 5970.5 6025.6 6029.6 6061.5 6118.1 6235.7 6238.8 6246.8 6253.2 01:31:42 INFO - PROCESS | 16536 | 01:31:42 INFO - PROCESS | 16536 | [#4] prototype.html Cycles:180 Average:4566.64 Median:5269.20 stddev:1327.77 (25.2%) stddev-sans-first:1292.44 01:31:42 INFO - PROCESS | 16536 | Values: 307.4 313.7 317.6 322.3 323.3 5197.6 5274.3 5286.3 5310.8 5333.5 5236.7 5245.7 5251.7 5255.7 5264.1 3919.6 4022.8 4100.2 4132.7 4135.3 4106.3 4106.4 4113.8 4128.7 4129.0 4051.9 4071.9 4083.3 4086.7 4096.9 3890.0 4000.7 4074.8 4078.7 4107.0 3621.1 3633.6 3635.8 3637.7 3640.6 5013.4 5014.2 5021.5 5023.2 5024.8 4705.9 4710.7 4715.2 4720.7 4729.6 5485.0 5510.4 5520.2 5520.9 5522.5 3975.9 3976.4 3982.3 3985.7 3986.1 5502.7 5694.5 5701.4 5705.7 5809.6 3886.8 3921.6 3924.7 3927.3 3934.8 3984.3 3985.5 3987.0 3988.1 3989.2 4594.2 4598.5 4602.6 4604.1 4604.3 5533.7 5535.6 5547.9 5554.5 5555.7 1389.7 1408.2 1409.6 1411.8 1411.9 895.7 922.3 935.8 939.5 957.3 4828.7 4832.5 4838.8 4855.6 4858.1 5628.4 5630.9 5688.5 5692.0 5694.6 4869.1 4870.5 4879.5 4880.5 4889.5 3033.0 3075.0 3086.3 3088.7 3093.1 5388.3 5393.1 5396.7 5402.4 5404.3 5630.1 5799.6 5803.5 5809.2 5816.7 5366.0 5386.5 5394.8 5395.2 5400.9 5668.7 5682.2 5683.9 5687.2 5687.4 5553.8 5555.7 5555.7 5559.9 5565.6 5365.5 5376.8 5378.5 5386.7 5393.0 3840.3 3946.6 3951.4 3956.8 3967.5 5617.7 5617.8 5630.2 5633.7 5653.5 5453.0 5459.0 5460.7 5461.5 5465.3 5407.1 5440.9 5443.3 5454.9 5465.8 5358.7 5385.8 5390.9 5392.4 5398.8 5350.1 5505.1 5509.6 5509.9 5517.6 5337.5 5341.6 5371.1 5375.7 5376.2 01:31:42 INFO - PROCESS | 16536 | 01:31:42 INFO - PROCESS | 16536 | [#5] yui.html Cycles:180 Average:12701.42 Median:40600.19 stddev:14242.54 (35.1%) stddev-sans-first:14253.49 01:31:42 INFO - PROCESS | 16536 | Values: 598.4 700.8 740.8 742.8 754.1 11766.2 12480.8 12586.9 12634.7 12645.4 11920.0 11974.3 12007.4 12010.2 12097.9 651.0 812.8 813.3 817.8 830.9 835.9 836.0 836.3 838.6 839.7 872.3 874.7 876.2 876.5 876.9 669.0 678.3 864.4 865.2 884.9 621.1 621.4 621.9 622.3 622.7 12455.3 12468.5 12490.8 12495.9 12497.3 12106.9 12431.9 12446.6 12612.0 12804.2 11249.8 11257.4 11381.7 11398.3 11751.4 3326.0 3355.5 3378.7 3394.7 3444.4 42695.0 42838.0 42927.4 43075.6 43438.1 10290.5 10449.6 10487.3 10554.1 10581.8 18078.9 18156.0 18291.2 18346.7 18368.0 6832.4 6851.9 6923.9 6982.0 6995.2 3819.0 3822.8 3823.2 3840.8 3849.7 2805.7 2817.0 2817.7 2838.1 2839.7 495.2 518.5 533.8 538.8 543.2 524.1 535.6 590.5 593.5 607.2 7992.2 8004.2 8264.8 8291.2 8317.0 599.8 605.4 619.9 632.9 639.3 3743.4 3864.2 3899.2 3918.0 3945.8 47496.5 50453.7 53805.0 55356.7 55546.4 44655.8 45304.8 45533.5 45719.8 46454.8 39976.2 40438.4 40510.2 40676.4 40934.4 8171.0 8227.9 8404.0 8409.7 8573.4 30614.0 30792.8 31671.3 31684.0 31751.5 38610.6 40229.2 40460.8 40524.0 40813.6 9920.5 10030.0 10275.1 10485.1 10512.1 10828.0 11009.2 11129.8 11234.4 11444.7 10112.6 10185.9 10289.3 10363.8 10406.0 10671.9 10679.0 10781.9 10788.1 10893.0 10279.6 10368.7 10625.2 10625.6 10699.7 8857.0 8920.7 8944.8 8993.2 9269.0 8750.6 9131.4 9142.8 9212.2 9370.8 01:31:42 INFO - PROCESS | 16536 | -------- Summary: end -------- 01:31:42 INFO - PROCESS | 16536 | 01:31:42 INFO - TEST-INFO | 16536: exit 0 01:31:42 INFO - TEST-OK | dromaeo_css | took 1115171ms 01:31:42 INFO - TEST-START | kraken 01:31:42 INFO - operating with platform_type : linux_ 01:31:42 INFO - Initialising browser for kraken test... 01:31:43 INFO - TEST-INFO | started process 16717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XkBDw/profile http://localhost:34773/getInfo.html) 01:31:47 INFO - PROCESS | 16717 | __metrics Screen width/height:1600/1200 01:31:47 INFO - PROCESS | 16717 | colorDepth:24 01:31:47 INFO - PROCESS | 16717 | Browser inner width/height: 1024/697 01:31:47 INFO - PROCESS | 16717 | __metrics 01:31:47 ERROR - PROCESS | 16717 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:31:48 INFO - TEST-INFO | 16717: exit 0 01:31:48 INFO - Browser initialized. 01:31:48 INFO - Running cycle 1/1 for kraken test... 01:31:48 INFO - TEST-INFO | started process 16796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XkBDw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:32:00 INFO - PROCESS | 16796 | RSS: Main: 154357760 01:32:00 INFO - PROCESS | 16796 | 01:32:03 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34773/tests/kraken/driver.html?testName=audio-beat-detection) 01:32:03 INFO - PROCESS | 16796 | RSS: Main: 194908160 01:32:03 INFO - PROCESS | 16796 | 01:32:06 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34773/tests/kraken/driver.html?testName=audio-dft) 01:32:07 INFO - PROCESS | 16796 | RSS: Main: 184705024 01:32:07 INFO - PROCESS | 16796 | 01:32:10 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34773/tests/kraken/driver.html?testName=audio-fft) 01:32:10 INFO - PROCESS | 16796 | RSS: Main: 169783296 01:32:10 INFO - PROCESS | 16796 | 01:32:12 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34773/tests/kraken/driver.html?testName=audio-oscillator) 01:32:13 INFO - PROCESS | 16796 | RSS: Main: 171786240 01:32:13 INFO - PROCESS | 16796 | 01:32:15 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:32:16 INFO - PROCESS | 16796 | RSS: Main: 173109248 01:32:16 INFO - PROCESS | 16796 | 01:32:19 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34773/tests/kraken/driver.html?testName=imaging-darkroom) 01:32:19 INFO - PROCESS | 16796 | RSS: Main: 173727744 01:32:19 INFO - PROCESS | 16796 | 01:32:23 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34773/tests/kraken/driver.html?testName=imaging-desaturate) 01:32:23 INFO - PROCESS | 16796 | RSS: Main: 174993408 01:32:23 INFO - PROCESS | 16796 | 01:32:26 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34773/tests/kraken/driver.html?testName=json-parse-financial) 01:32:27 INFO - PROCESS | 16796 | RSS: Main: 174047232 01:32:27 INFO - PROCESS | 16796 | 01:32:29 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:32:29 INFO - PROCESS | 16796 | RSS: Main: 182579200 01:32:29 INFO - PROCESS | 16796 | 01:32:31 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:32:32 INFO - PROCESS | 16796 | RSS: Main: 181112832 01:32:32 INFO - PROCESS | 16796 | 01:32:34 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:32:34 INFO - PROCESS | 16796 | RSS: Main: 192606208 01:32:34 INFO - PROCESS | 16796 | 01:32:37 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:32:37 INFO - PROCESS | 16796 | RSS: Main: 197922816 01:32:37 INFO - PROCESS | 16796 | 01:32:40 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:32:41 INFO - PROCESS | 16796 | RSS: Main: 197431296 01:32:41 INFO - PROCESS | 16796 | 01:32:42 INFO - PROCESS | 16796 | Cycle 1(1): loaded http://localhost:34773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34773/tests/kraken/driver.html?testName=ai-astar) 01:32:43 INFO - PROCESS | 16796 | RSS: Main: 259063808 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | __start_tp_report 01:32:43 INFO - PROCESS | 16796 | _x_x_mozilla_page_load 01:32:43 INFO - PROCESS | 16796 | _x_x_mozilla_page_load_details 01:32:43 INFO - PROCESS | 16796 | |i|pagename|runs| 01:32:43 INFO - PROCESS | 16796 | |0;ai-astar;111;112;106;112;114;115;101;113;111;111 01:32:43 INFO - PROCESS | 16796 | |1;audio-beat-detection;155;130;158;167;131;158;156;132;178;136 01:32:43 INFO - PROCESS | 16796 | |2;audio-dft;162;160;161;162;160;161;161;161;160;159 01:32:43 INFO - PROCESS | 16796 | |3;audio-fft;77;73;109;96;73;73;73;118;104;72 01:32:43 INFO - PROCESS | 16796 | |4;audio-oscillator;93;94;132;94;93;94;136;93;94;139 01:32:43 INFO - PROCESS | 16796 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;117;119;117 01:32:43 INFO - PROCESS | 16796 | |6;imaging-darkroom;146;146;147;146;146;146;146;145;145;148 01:32:43 INFO - PROCESS | 16796 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 01:32:43 INFO - PROCESS | 16796 | |8;json-parse-financial;65;66;64;66;65;64;64;75;62;63 01:32:43 INFO - PROCESS | 16796 | |9;json-stringify-tinderbox;64;64;63;64;64;66;65;63;64;64 01:32:43 INFO - PROCESS | 16796 | |10;stanford-crypto-aes;81;82;81;80;83;84;82;89;81;84 01:32:43 INFO - PROCESS | 16796 | |11;stanford-crypto-ccm;116;115;125;115;116;117;116;122;121;118 01:32:43 INFO - PROCESS | 16796 | |12;stanford-crypto-pbkdf2;142;130;155;140;139;130;141;138;131;142 01:32:43 INFO - PROCESS | 16796 | |13;stanford-crypto-sha256-iterative;68;67;68;67;66;66;68;68;66;66 01:32:43 INFO - PROCESS | 16796 | __end_tp_report 01:32:43 INFO - PROCESS | 16796 | __start_cc_report 01:32:43 INFO - PROCESS | 16796 | _x_x_mozilla_cycle_collect,1184 01:32:43 INFO - PROCESS | 16796 | __end_cc_report 01:32:43 INFO - PROCESS | 16796 | __startTimestamp1459845163041__endTimestamp 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | ------- Summary: start ------- 01:32:43 INFO - PROCESS | 16796 | Number of tests: 14 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:4.14 (3.7%) stddev-sans-first:4.39 01:32:43 INFO - PROCESS | 16796 | Values: 111.0 112.0 106.0 112.0 114.0 115.0 101.0 113.0 111.0 111.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:157.00 stddev:16.81 (10.7%) stddev-sans-first:17.73 01:32:43 INFO - PROCESS | 16796 | Values: 155.0 130.0 158.0 167.0 131.0 158.0 156.0 132.0 178.0 136.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 01:32:43 INFO - PROCESS | 16796 | Values: 162.0 160.0 161.0 162.0 160.0 161.0 161.0 161.0 160.0 159.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#3] audio-fft Cycles:10 Average:86.80 Median:73.00 stddev:18.02 (24.7%) stddev-sans-first:18.76 01:32:43 INFO - PROCESS | 16796 | Values: 77.0 73.0 109.0 96.0 73.0 73.0 73.0 118.0 104.0 72.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#4] audio-oscillator Cycles:10 Average:106.20 Median:93.50 stddev:20.41 (21.8%) stddev-sans-first:21.08 01:32:43 INFO - PROCESS | 16796 | Values: 93.0 94.0 132.0 94.0 93.0 94.0 136.0 93.0 94.0 139.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.87 01:32:43 INFO - PROCESS | 16796 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 119.0 117.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 01:32:43 INFO - PROCESS | 16796 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 145.0 148.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:32:43 INFO - PROCESS | 16796 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.00 stddev:3.60 (5.5%) stddev-sans-first:3.81 01:32:43 INFO - PROCESS | 16796 | Values: 65.0 66.0 64.0 66.0 65.0 64.0 64.0 75.0 62.0 63.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 01:32:43 INFO - PROCESS | 16796 | Values: 64.0 64.0 63.0 64.0 64.0 66.0 65.0 63.0 64.0 64.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:2.58 (3.1%) stddev-sans-first:2.67 01:32:43 INFO - PROCESS | 16796 | Values: 81.0 82.0 81.0 80.0 83.0 84.0 82.0 89.0 81.0 84.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:117.50 stddev:3.41 (2.9%) stddev-sans-first:3.54 01:32:43 INFO - PROCESS | 16796 | Values: 116.0 115.0 125.0 115.0 116.0 117.0 116.0 122.0 121.0 118.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:140.50 stddev:7.50 (5.3%) stddev-sans-first:7.86 01:32:43 INFO - PROCESS | 16796 | Values: 142.0 130.0 155.0 140.0 139.0 130.0 141.0 138.0 131.0 142.0 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - PROCESS | 16796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:0.94 (1.4%) stddev-sans-first:0.93 01:32:43 INFO - PROCESS | 16796 | Values: 68.0 67.0 68.0 67.0 66.0 66.0 68.0 68.0 66.0 66.0 01:32:43 INFO - PROCESS | 16796 | -------- Summary: end -------- 01:32:43 INFO - PROCESS | 16796 | 01:32:43 INFO - TEST-INFO | 16796: exit 0 01:32:43 INFO - TEST-OK | kraken | took 60883ms 01:32:43 INFO - SUITE-END | took 1176s 01:32:44 INFO - Completed test suite (00:19:36) 01:32:44 INFO - javascript benchmark 01:32:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2585.586306191009, 2664.440467501823, 2674.598810178472, 2682.825616334938, 2704.553748631475, 4501.7524036178, 4563.338315944195, 4563.589276965073, 4577.198990176722, 4592.632589392849, 4569.063342014887, 4593.494715581283, 4597.172508948388, 4658.604018658418, 4674.0, 4189.706720529556, 4199.7480151190875, 4204.957950420502, 4229.513605935311, 4340.826366945318, 4303.182395344875, 4316.223079845627, 4338.089001309729, 4369.410129632491, 4372.3878656988045, 4155.293600087993, 4196.685248606336, 4249.702520823544, 4266.040140968273, 4274.316109422478, 4247.193033323659, 4262.680298977558, 4263.317869140954, 4303.203907277132, 4306.052668412975, 4239.618434340893, 4241.660667146621, 4253.1706317268145, 4286.635635970915, 4287.0, 4386.188555117282, 4463.709858859196, 4501.347304640842, 4556.316552517116, 4572.039871626962, 4900.338454308659, 4904.068227036852, 4924.3105965164905, 4927.0, 4977.477364876672, 4940.135476291634, 4947.0, 4949.529794669501, 4950.4801995790285, 5000.549950504472, 4506.729596224204, 4571.885702857388, 4620.722756634613, 4645.837395691135, 4659.044895796354, 5018.749062546858, 5031.723255220998, 5041.01700168471, 5050.339974347191, 5073.695578265316, 4708.411448568929, 4836.274558816135, 4837.201861692852, 4837.588804951548, 4877.0, 4837.443693975168, 4873.390826146731, 4913.164761990399, 4914.926276105862, 4922.8769280768265, 4772.427308722976, 4787.8563643090765, 4790.065937142223, 4797.928031079537, 4841.273808928619, 4698.2952557116705, 4770.499097594772, 4775.379200703956, 4782.067496838084, 4829.806807727722, 4064.6545043671617, 4119.032027473541, 4120.835166593302, 4154.854580089743, 4161.812718427678, 3607.026102952188, 3619.1675914539805, 3624.293262813726, 3653.2328211075974, 3658.5243918290985, 4222.134462435193, 4285.400043993844, 4286.357046443059, 4289.935650965238, 4301.2257793597455, 4864.440589332201, 4921.040397122527, 4922.852314430573, 4927.876803079952, 4969.0310389474425, 4256.106217694257, 4260.616544511009, 4285.309287323629, 4307.0, 4325.675574331937, 4281.0, 4320.265554855682, 4354.303311470149, 4407.691461597721, 4493.842715504941, 4710.882227944328, 4717.221658426459, 4719.693219940624, 4739.478657347689, 4746.311784791255, 4974.527419895104, 4987.80048798044, 4989.276554899592, 4991.725455099859, 5035.823746168867, 4584.724916504887, 4681.485036646034, 4712.175369310288, 4758.2386818108935, 4767.499412561631, 4877.707337559757, 4878.487758785276, 4900.4854490278, 4903.092927808367, 4947.109520286383, 4943.134951383421, 4956.950430495649, 4961.131801934719, 4967.801287948441, 5010.724410157476, 4682.2508398656055, 4714.905701885875, 4769.499202583679, 4790.0, 4823.397075365579, 4745.074710431432, 4762.928556071731, 4783.593394561502, 4786.0667169901535, 4824.8793780155775, 4643.605293550086, 4738.123447162286, 4754.477007529238, 4755.089058524096, 4813.975930120327, 4795.904081918412, 4839.516048395132, 4841.394825646794, 4869.9026019480125, 4893.09477746618, 4668.673192876466, 4716.693414928019, 4722.197226471577, 4722.268048452495, 4764.714117152982], "unit": "score", "name": "dojo.html", "value": 4524.359405683179}, {"lowerIsBetter": false, "replicates": [540.5486418840269, 553.8781468077021, 559.7900787204799, 567.6452217364148, 577.745791851585, 27955.301117472074, 28296.43407131859, 36414.635853641455, 36544.0, 36547.451788223196, 39392.0, 39977.80011099941, 39993.800030999875, 40011.999100067536, 40021.799891000504, 7564.432667549928, 7741.57421341826, 7745.7676269712, 7748.651310691004, 7749.30256276935, 7862.449628526006, 7998.440109192359, 8015.639296231654, 8015.839683206333, 8016.599170041474, 7967.402444816633, 8083.151269116746, 8084.636191371403, 8084.71703490378, 8085.029796424408, 7895.565743884084, 7938.126806051329, 7950.244726751007, 7975.32209762168, 8021.799455013613, 7864.4888082274465, 8025.398095142829, 8025.3980951428875, 8028.438009339348, 8029.638666259974, 38484.42273365902, 38942.610573894184, 38954.22091558181, 39074.60925390738, 39108.60891391078, 3249.820691019721, 3326.9500957485416, 3392.525046493493, 3673.651003154696, 3785.1861849702173, 27904.860475697493, 29515.409691806257, 29860.701392986226, 30193.09420717382, 30690.23274418135, 3483.2685136121445, 3545.1137215696076, 3553.662402071825, 3593.7843729376323, 3635.309291234657, 244931.0, 245355.0, 246012.0, 246914.0, 247078.0, 57018.71490642603, 57163.0, 57572.0, 57623.847523049306, 57653.42346576564, 53845.73077134667, 60723.392766071775, 60955.39044609497, 63980.360196398375, 65211.67394162999, 15000.924995374953, 15644.843551564567, 15661.921690391702, 15679.137647429501, 15694.293756780973, 11430.085593152528, 11691.88308116925, 11695.415229238504, 11697.532098716127, 11703.941480292544, 17415.216315265843, 19726.40820775379, 19733.013349332763, 21049.473763156042, 21190.682139767916, 7434.219406962299, 7480.803071508642, 7601.429892758065, 7647.273509016746, 7650.579218143055, 940.7318914109446, 947.8341290274175, 956.5217391304348, 963.0706368354571, 977.1352353167498, 25207.87396063008, 25911.22266332013, 25936.092236771623, 26135.869320653273, 26241.34396640061, 919.544825311475, 997.5710444508786, 998.7403275148514, 1021.6985989133224, 1082.5453309609982, 13598.504164541893, 13924.930375348058, 14205.928970355082, 14209.431622734975, 14228.296623641476, 291397.0, 295071.0, 295296.0, 297606.0, 298075.0, 49243.50756492461, 49510.257346139835, 49511.0, 49542.0, 49600.751996239786, 1072.265498133781, 1210.0924306769923, 1246.1339369138543, 1249.3940438887314, 1269.9492020319083, 25666.358341041625, 26752.8662356687, 26759.19722408331, 26970.460590788465, 27222.183334499998, 38543.614563854004, 44463.55536444594, 45083.54916450794, 45099.549004510845, 45113.0977380444, 181794.0, 182668.0, 183668.0, 183711.0, 183840.0, 30264.394712106074, 30711.0, 30762.538561922036, 30763.0, 30764.538531922488, 38720.2255954885, 40223.1955360897, 40583.39124913188, 42380.36429453499, 43472.78263608662, 36279.455808163424, 36497.45253821248, 36523.26953460969, 36613.63386366102, 36865.44701829529, 35241.47137792986, 35376.46935295921, 35443.291134177685, 35529.289414212086, 35589.28821423609, 34661.30677386488, 35212.823935881184, 35241.118972025906, 35639.0, 36007.0, 31744.04767856968, 31747.085877408466, 32095.35809283848, 32123.357532848746, 32124.03627891167, 25117.87441062783, 25142.62286065674, 25305.367365816, 25511.36221594475, 25573.232803015195], "unit": "score", "name": "ext.html", "value": 17426.14687953515}, {"lowerIsBetter": false, "replicates": [346.5512161750534, 350.8333541567755, 359.7553663508814, 363.7926381962279, 367.15187915914225, 15360.692786144284, 15579.688406231882, 15602.921985390072, 15805.051696898165, 15912.76130858038, 15167.241637918116, 15349.616259593487, 16091.597710057255, 16142.950708203958, 16161.676766464663, 4875.70745755254, 5078.5937125029905, 5078.796848126089, 5083.974580127094, 5186.818461353853, 5329.360476742796, 5338.065838478251, 5349.197620356938, 5371.409144994048, 5374.193870919374, 5258.815941442051, 5339.39818054584, 5354.41101478837, 5356.303680521527, 5366.034113859504, 5302.6023048271345, 5323.707196104213, 5401.27082843815, 5432.130859062531, 5445.292112025451, 5218.086834803894, 5232.764525596357, 5309.5752339812725, 5316.627836051478, 5318.042752304584, 16917.407890723767, 19171.32900348481, 19635.116419761, 19642.214311427524, 19649.312274070482, 1885.8774179678278, 2031.9796802031938, 2079.781622929601, 2423.369923819802, 2432.513497300547, 9209.171174594252, 9708.805823883553, 9900.80198396028, 10293.691189264335, 13079.542216022488, 1780.1188411736273, 1793.3543924187281, 1794.1836464408664, 1804.3865085870736, 1836.2471386731509, 41717.0, 44463.0, 54499.91000180014, 60399.0, 61280.387196127915, 9322.927863295672, 9551.235901127893, 9609.327347085637, 9762.609495620096, 9849.261305402124, 13378.13042152257, 13434.596962091153, 13449.865501345057, 13533.39099740514, 13556.728865422636, 6506.3493650634555, 6981.616011119438, 6988.545744526589, 7169.354758071694, 7193.89209161863, 6756.425703815231, 6776.69504872282, 6852.28051054642, 6865.41643960269, 6870.725170993104, 4141.088960428761, 4175.791210439465, 4198.769067701306, 4263.381809637585, 4265.274903266452, 1724.2758041622549, 1742.1637613945377, 1778.0931724820175, 1787.6067265201634, 1821.3625231169249, 833.9791505212297, 851.1105894340305, 862.8446879561614, 867.8481265778463, 879.4855009819328, 15592.844071559366, 15930.522084337488, 16206.108664023592, 16327.510174694778, 16641.50075497713, 851.4550687559843, 867.3451544084176, 870.2037635563515, 898.820235952799, 899.2670973156987, 8873.911260887438, 9223.861642075375, 9337.066293370744, 9528.428294302365, 9640.373375730554, 416723.0, 420617.0, 427549.0, 432384.0, 435189.0, 70864.64567677231, 72323.63838180776, 72703.2729672707, 73071.26928730751, 74467.62766186243, 938.638624129715, 940.3182692547848, 962.8940816510178, 965.1072757699101, 972.4894430424084, 15144.772828407362, 15193.316300766272, 15300.693986119993, 15307.234638267819, 15397.153156576047, 33204.50193247152, 34254.657453426145, 34646.13384665403, 34764.0, 34975.0, 47638.523614763406, 48489.5151048485, 48583.27125093056, 48633.756831215615, 48979.75510122427, 7776.611169441619, 7799.805004874924, 7808.648610812641, 7867.763967080997, 7946.125926148235, 10649.840252396065, 11803.704907377385, 11913.166078374777, 11945.761084778429, 12099.57651482194, 10227.0, 10305.587776488857, 10369.585216591251, 10508.947455262674, 10571.154307655523, 10008.949955250177, 10147.695569132939, 10171.389716617026, 10212.693619191436, 10327.586896524055, 10164.0, 10437.478126093512, 10566.630167944393, 10593.682189534018, 10768.3538987661, 7321.560706357635, 7476.25237476248, 7612.086549614081, 7643.7324693635455, 7645.923540764521, 9432.292578056537, 10072.84890726625, 10326.741831454274, 10328.328658637165, 10362.222833287382], "unit": "score", "name": "jquery.html", "value": 8073.955269875006}, {"lowerIsBetter": false, "replicates": [1282.0640932119559, 1362.0805955979715, 1390.158953832931, 1492.410497853348, 1712.8287171282882, 6376.585521941076, 6694.6987385567645, 6797.0, 6802.7619033333785, 6804.931950680504, 6939.27137650547, 7082.504224704273, 7085.2560481149385, 7087.362137407632, 7087.787366379017, 1874.5594785225462, 2140.6039882621685, 2155.3426205007468, 2177.629802933501, 2204.239537359608, 2129.084493667722, 2169.4684802223396, 2170.967435488469, 2173.7282839645045, 2174.8695078295355, 2096.3186964236606, 2097.1192099318323, 2103.737032870891, 2104.2109209046607, 2105.1368938735122, 2075.989620051905, 2091.393495886191, 2103.5161912760072, 2106.662933930579, 2123.830093592509, 2132.1364847236896, 2150.677398390254, 2161.0815403453626, 2164.7402311722694, 2167.945801354963, 6949.548279361826, 6971.5468494547695, 6996.195437524699, 7009.824754381181, 7019.473539484559, 4438.755868427235, 4549.135664223787, 4555.385023021916, 4556.088782243532, 4562.703424277412, 2842.0, 2901.956470652942, 2928.9707102929124, 2949.823010619348, 2954.0, 915.9862602060974, 917.921976631987, 954.2413781044087, 962.1100482054142, 979.4906648542789, 9609.039096090404, 9652.710418687451, 9653.0, 9655.03449655036, 9660.806783864353, 3995.20095980805, 4082.510098788164, 4153.439285696392, 4178.39413285072, 4179.937300940488, 8417.957910210409, 8477.448965817202, 8501.489910605384, 8506.31949444043, 8515.361347898932, 3840.02079469739, 4591.288350305708, 4591.517890621503, 4595.563421474954, 4597.908041839144, 4062.6343629072935, 4113.0, 4116.567760385176, 4131.50421949368, 4133.441985331941, 3397.96362109554, 3477.669621386015, 3511.4206155983975, 3532.3465158945164, 3534.505169276303, 1133.2916926920675, 1171.8769529199483, 1173.0674114079327, 1179.3985067615579, 1189.52419032386, 980.2941881845203, 1018.2668478695327, 1167.7606090751376, 1173.530587764901, 1184.3841202574786, 6620.040094186316, 6693.564918280296, 6707.094542236736, 6707.295733947963, 6717.16035495563, 1091.0889407344798, 1098.3355070182583, 1111.5942680921567, 1122.825961975895, 1143.9256448330832, 5233.371995360505, 5270.92093618596, 5346.331708536433, 5355.437679043722, 5355.785768569292, 8303.8339233215, 8456.196661317164, 8479.06730259671, 8534.061253262136, 8536.317094632415, 8270.710525131592, 8360.665573376997, 8443.366747493963, 8489.066202717697, 8731.825363492822, 6884.793456196322, 6943.132108486439, 6972.302769722987, 6998.090248267693, 7035.788926332219, 6530.8367290818105, 6565.967170164118, 6594.637294948824, 6605.669716514059, 6620.90068648961, 7536.849263014599, 7806.531608103532, 7839.882401763864, 8005.679772809022, 8025.478343907627, 7784.727534536264, 7906.960465197637, 8024.679012839421, 8041.557714325534, 8153.6738530458115, 5299.735013249399, 5819.5053420459735, 5966.67183304905, 6016.789412370546, 6139.77204559081, 6698.799036028927, 6701.497387696039, 6714.832129196614, 6740.730370785113, 6751.628660423724, 5971.223740913827, 6045.969770151297, 6140.447359737466, 6142.600730952474, 6150.323464419, 6101.328853826164, 6170.9074363885475, 6198.101275315144, 6262.09199666055, 6277.466415354746, 6482.902756458751, 6552.541322107407, 6561.901571476527, 6565.573237739532, 6579.078928950046, 5968.4926781224085, 5970.492508136857, 6025.6083354581815, 6029.638221706711, 6061.545384096122, 6118.051701986199, 6235.719392627252, 6238.812835614939, 6246.812595622138, 6253.218347706536], "unit": "score", "name": "mootools.html", "value": 4171.251757210619}, {"lowerIsBetter": false, "replicates": [307.448130605563, 313.6847468294364, 317.60458229504263, 322.3247296912966, 323.2677984365411, 5197.584193264539, 5274.340707411574, 5286.259923610698, 5310.814121505743, 5333.466653334664, 5236.659617124894, 5245.659032162906, 5251.658642188255, 5255.684658920468, 5264.052470555299, 3919.5884432134644, 4022.839086436539, 4100.200460910109, 4132.669386449077, 4135.27632664284, 4106.342985122381, 4106.363513655373, 4113.794310284488, 4128.731632443882, 4128.97935510322, 4051.898702532431, 4071.857484988026, 4083.3262511685684, 4086.652634526054, 4096.8975775605695, 3889.961100388988, 4000.679945604359, 4074.816633251481, 4078.714489985702, 4106.958930410688, 3621.0947263184203, 3633.6003039665616, 3635.836387362575, 3637.7089832813576, 3640.5631324240994, 5013.373328333958, 5014.172661510846, 5021.472745361758, 5023.196288593807, 5024.819167495635, 4705.929411058837, 4710.717356958594, 4715.245560710304, 4720.716756994591, 4729.62163026957, 5485.040117979377, 5510.401983424802, 5520.171974203901, 5520.889582208333, 5522.502974732293, 3975.940360894589, 3976.3836605325932, 3982.3230050891416, 3985.6612187964056, 3986.063275130342, 5502.697351645658, 5694.544436445074, 5701.372848986608, 5705.686187259699, 5809.564282678816, 3886.7862267574988, 3921.568627450978, 3924.7448915820382, 3927.2930872443235, 3934.842606295716, 3984.2828290907914, 3985.5217373915316, 3986.980065099714, 3988.062805240766, 3989.2221016901426, 4594.2419500782, 4598.471175814757, 4602.631789456836, 4604.102200071021, 4604.263317869125, 5533.723313834292, 5535.640183388067, 5547.944520554743, 5554.50009499147, 5555.694436805934, 1389.673426744714, 1408.1621435246218, 1409.584172669065, 1411.7999700254907, 1411.8799902008445, 895.6686026170229, 922.294444749767, 935.7520257131865, 939.4691999020669, 957.2912351452624, 4828.734419606885, 4832.4684284728655, 4838.782254798542, 4855.587275081658, 4858.101251268456, 5628.437156284421, 5630.859228519238, 5688.516476099578, 5692.0, 5694.60137790359, 4869.147899117711, 4870.464248932614, 4879.487653796371, 4880.487548807324, 4889.462159162489, 3033.0445909538425, 3074.969250307513, 3086.3364376659124, 3088.722015018659, 3093.072078376523, 5388.272583201296, 5393.056215162331, 5396.703181324986, 5402.405735369106, 5404.32445944257, 5630.071038278638, 5799.594028418054, 5803.47768700819, 5809.215755872988, 5816.738246778905, 5365.9731701342025, 5386.5152136307925, 5394.757235924393, 5395.244665746799, 5400.891982160413, 5668.688222147822, 5682.232898558642, 5683.8863222736145, 5687.232223649754, 5687.402822703557, 5553.750081246434, 5555.694436806015, 5555.72221388937, 5559.861003474945, 5565.610407271614, 5365.490278423544, 5376.838694839161, 5378.542823860016, 5386.676799392049, 5393.0, 3840.327942609976, 3946.565877753387, 3951.407288906687, 3956.7823769692945, 3967.464392307117, 5617.662940223599, 5617.775288988395, 5630.23991761107, 5633.6619802811965, 5653.462921022497, 5452.972735136299, 5459.0, 5460.726963651722, 5461.481159289861, 5465.316835395575, 5407.080796264566, 5440.945590544044, 5443.319585051869, 5454.8909021818545, 5465.754041068082, 5358.678479291255, 5385.75764090609, 5390.946090539202, 5392.433794451526, 5398.811041613525, 5350.117230657053, 5505.064139096283, 5509.641873278384, 5509.889802204014, 5517.641353312022, 5337.546308563816, 5341.608078870023, 5371.140617501337, 5375.704336261543, 5376.193570964387], "unit": "score", "name": "prototype.html", "value": 4141.815083513659}, {"lowerIsBetter": false, "replicates": [598.4315940176656, 700.8458139209374, 740.7703611880314, 742.7920182348944, 754.0574282147315, 11766.235194712337, 12480.750384992294, 12586.874131258684, 12634.684132896682, 12645.430955606997, 11920.046396288299, 11974.34141122238, 12007.399630018508, 12010.21933574317, 12097.939510302458, 651.0332156747227, 812.8252425728467, 813.2802469814227, 817.791463176889, 830.8919840420737, 835.9498430094184, 835.995820020899, 836.2515548584014, 838.5597561280316, 839.7019058234331, 872.3283072034561, 874.6894852327428, 876.1895246896627, 876.5135349880813, 876.8947726272856, 668.9598624082546, 678.2945736434078, 864.3517361978517, 865.2342676731075, 884.920357167858, 621.1304174156172, 621.4034526854225, 621.9036049412348, 622.2719418280623, 622.6699849079995, 12455.252684838939, 12468.501259949591, 12490.75018499634, 12495.937520312431, 12497.312647804367, 12106.939465302705, 12431.875681243162, 12446.564370246997, 12612.011629296261, 12804.231746095264, 11249.83125253122, 11257.380844053574, 11381.700830693802, 11398.316101033965, 11751.353675547842, 3326.0, 3355.463125899869, 3378.7297016238886, 3394.728421726256, 3444.431668774649, 42695.0, 42838.0, 42927.35608965868, 43075.569244307786, 43438.13123737539, 10290.536925838354, 10449.634262800766, 10487.26589138753, 10554.10290125348, 10581.84127238092, 18078.90960545189, 18156.0, 18291.1768970394, 18346.724799128024, 18368.0, 6832.385085342343, 6851.931480685229, 6923.9307606923285, 6982.0, 6995.160580730345, 3818.961810381916, 3822.8470861165797, 3823.1589050408866, 3840.7503512271614, 3849.6535311821513, 2805.677347105109, 2816.971830281712, 2817.690054094048, 2838.1485554333617, 2839.673437554666, 495.2496967094854, 518.4918779595941, 533.8265063854263, 538.8388023808699, 543.228615366181, 524.0645447875523, 535.5902734408181, 590.539379284159, 593.5162842283526, 607.2106261859565, 7992.240737129963, 8004.159563245892, 8264.752057438287, 8291.170882911782, 8316.958415207886, 599.8350453625201, 605.4339192854695, 619.8729260501586, 632.9303776584665, 639.341478277375, 3743.401055831054, 3864.2078373933837, 3899.1811719539214, 3917.980410097988, 3945.8027098644952, 47496.5250347499, 50453.74773126111, 53805.0, 55356.72321638366, 55546.444535554125, 44655.77672111684, 45304.77347613241, 45533.54466455359, 45719.771401143444, 46454.76772616183, 39976.200475990314, 40438.39342409925, 40510.1897962045, 40676.389854152214, 40934.38598421026, 8171.0, 8227.917720822716, 8404.033536143177, 8409.705660301861, 8573.356998225034, 30614.0, 30792.84603576968, 31671.258080804855, 31684.0, 31751.523727144573, 38610.613893861824, 40229.1954160921, 40460.79769601133, 40524.0, 40813.591864080976, 9920.52101788537, 10030.0, 10275.126614237874, 10485.108765754996, 10512.053915147673, 10828.0, 11009.229353945148, 11129.777404451703, 11234.382108984084, 11444.713882153013, 10112.59549618007, 10185.898141018792, 10289.279750417698, 10363.792724145625, 10406.0, 10671.893281067401, 10679.038886500251, 10781.892181078403, 10788.083012943987, 10893.0, 10279.588816447258, 10368.688939331832, 10625.203109766953, 10625.628103016667, 10699.679009629723, 8857.0, 8920.687775927812, 8944.776380590278, 8993.235574975939, 9269.0, 8750.562471876508, 9131.406458580172, 9142.817143657223, 9212.170904618617, 9370.812583748151], "unit": "score", "name": "yui.html", "value": 5941.813513179248}], "name": "dromaeo_css", "value": 6346.649552933199}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 112.0, 114.0, 115.0, 101.0, 113.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [155.0, 130.0, 158.0, 167.0, 131.0, 158.0, 156.0, 132.0, 178.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 160.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 109.0, 96.0, 73.0, 73.0, 73.0, 118.0, 104.0, 72.0], "unit": "score", "name": "audio-fft", "value": 86.8}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 132.0, 94.0, 93.0, 94.0, 136.0, 93.0, 94.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 119.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 64.0, 66.0, 65.0, 64.0, 64.0, 75.0, 62.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 65.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 66.0, 65.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 81.0, 80.0, 83.0, 84.0, 82.0, 89.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 125.0, 115.0, 116.0, 117.0, 116.0, 122.0, 121.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [142.0, 130.0, 155.0, 140.0, 139.0, 130.0, 141.0, 138.0, 131.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 67.0, 66.0, 66.0, 68.0, 68.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1508.3999999999999}]} 01:32:44 INFO - Return code: 0 01:32:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:32:44 ERROR - # TBPL SUCCESS # 01:32:44 INFO - Running post-action listener: _resource_record_post_action 01:32:44 INFO - Running post-run listener: _resource_record_post_run 01:32:45 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520704000; Read time: 12; Write time: 476648 01:32:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 224346112; Read time: 0; Write time: 285560 01:32:45 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287563776; Read time: 12; Write time: 186112 01:32:45 INFO - Running post-run listener: _upload_blobber_files 01:32:45 INFO - Blob upload gear active. 01:32:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:32:45 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 01:32:45 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'] 01:32:45 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 01:32:45 INFO - (blobuploader) - INFO - Open directory for files ... 01:32:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:32:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:32:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:32:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:32:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:32:46 INFO - (blobuploader) - INFO - Done attempting. 01:32:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:32:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:32:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:32:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:32:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:32:48 INFO - (blobuploader) - INFO - Done attempting. 01:32:48 INFO - (blobuploader) - INFO - Iteration through files over. 01:32:48 INFO - Return code: 0 01:32:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:32:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:32:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/42baefcee14a649db156ea3cbac3f3ae427e6048636a184cc6f99fe84648338d9ea31f97ef911800b3869b3dd3e557be8117b00859afd2555f4e5f1c8e1218a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d69257bf82f432991c05c895a8f9f685c0b557ac3f508eed216727c4eaee1b08a29064739b529ed7a146d8d8f4a5aaad1c19f898d2a58e2375ad4620bb11f720"} 01:32:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:32:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:32:48 INFO - Contents: 01:32:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/42baefcee14a649db156ea3cbac3f3ae427e6048636a184cc6f99fe84648338d9ea31f97ef911800b3869b3dd3e557be8117b00859afd2555f4e5f1c8e1218a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d69257bf82f432991c05c895a8f9f685c0b557ac3f508eed216727c4eaee1b08a29064739b529ed7a146d8d8f4a5aaad1c19f898d2a58e2375ad4620bb11f720"} 01:32:48 INFO - Running post-run listener: copy_logs_to_upload_dir 01:32:48 INFO - Copying logs to upload dir... 01:32:48 INFO - mkdir: /builds/slave/test/build/upload/logs 01:32:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.971604 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-05 01:32:48.415794) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 01:32:48.419104) ========= 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=82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681 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/42baefcee14a649db156ea3cbac3f3ae427e6048636a184cc6f99fe84648338d9ea31f97ef911800b3869b3dd3e557be8117b00859afd2555f4e5f1c8e1218a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d69257bf82f432991c05c895a8f9f685c0b557ac3f508eed216727c4eaee1b08a29064739b529ed7a146d8d8f4a5aaad1c19f898d2a58e2375ad4620bb11f720"} build_url:https://queue.taskcluster.net/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/GfgVuzrFQdWGkUXv7kL7OQ/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/42baefcee14a649db156ea3cbac3f3ae427e6048636a184cc6f99fe84648338d9ea31f97ef911800b3869b3dd3e557be8117b00859afd2555f4e5f1c8e1218a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d69257bf82f432991c05c895a8f9f685c0b557ac3f508eed216727c4eaee1b08a29064739b529ed7a146d8d8f4a5aaad1c19f898d2a58e2375ad4620bb11f720"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 01:32:48.447852) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:32:48.448537) ========= 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=82e07478c745e68b1fe4678a000001bc-1459841288.795674-1277162681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:32:48.530450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 01:32:48.531033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 01:32:48.531751) ========= ========= Total master_lag: 0.40 =========